builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1475562582.49 results: success (0) buildid: 20161003213045 builduid: 050004a692aa4a1bb3fafeb04fc291f8 revision: 625a597ea7e3557d18487cf1616eb599f8ba34a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.494072) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.494493) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.494781) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.509016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.509274) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 23:29:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-10-03 23:29:43 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103415 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.626030) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.626339) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022012 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.675004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:42.675316) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 625a597ea7e3557d18487cf1616eb599f8ba34a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 625a597ea7e3557d18487cf1616eb599f8ba34a2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 23:29:43,276 truncating revision to first 12 chars 2016-10-03 23:29:43,276 Setting DEBUG logging. 2016-10-03 23:29:43,276 attempt 1/10 2016-10-03 23:29:43,276 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/625a597ea7e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 23:29:43,578 unpacking tar archive at: mozilla-inbound-625a597ea7e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618170 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:43.306570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:43.306900) ========= script_repo_revision: 625a597ea7e3557d18487cf1616eb599f8ba34a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:43.307279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:43.307580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 23:29:43.318848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-03 23:29:43.319343) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:29:44 INFO - MultiFileLogger online at 20161003 23:29:44 in /builds/slave/test 23:29:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 23:29:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:29:44 INFO - {'append_to_log': False, 23:29:44 INFO - 'base_work_dir': '/builds/slave/test', 23:29:44 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 23:29:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:29:44 INFO - 'branch': 'Mozilla-Inbound', 23:29:44 INFO - 'buildbot_json_path': 'buildprops.json', 23:29:44 INFO - 'config_files': ('talos/linux_config.py',), 23:29:44 INFO - 'default_actions': ('clobber', 23:29:44 INFO - 'read-buildbot-config', 23:29:44 INFO - 'download-and-extract', 23:29:44 INFO - 'populate-webroot', 23:29:44 INFO - 'create-virtualenv', 23:29:44 INFO - 'install', 23:29:44 INFO - 'run-tests'), 23:29:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:29:44 INFO - 'download_minidump_stackwalk': True, 23:29:44 INFO - 'download_symbols': 'ondemand', 23:29:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:29:44 INFO - 'tooltool.py': '/tools/tooltool.py', 23:29:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:29:44 INFO - '/tools/misc-python/virtualenv.py')}, 23:29:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:29:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:29:44 INFO - 'installer_path': 'installer.exe', 23:29:44 INFO - 'log_level': 'info', 23:29:44 INFO - 'log_name': 'talos', 23:29:44 INFO - 'log_to_console': True, 23:29:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:29:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:29:44 INFO - 'opt_config_files': (), 23:29:44 INFO - 'pip_index': False, 23:29:44 INFO - 'sps_profile': False, 23:29:44 INFO - 'sps_profile_interval': 0, 23:29:44 INFO - 'suite': 'dromaeojs-e10s', 23:29:44 INFO - 'system_bits': '32', 23:29:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:29:44 INFO - 'title': 'talos-linux64-ix-067', 23:29:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:29:44 INFO - 'use_talos_json': True, 23:29:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:29:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:29:44 INFO - 'work_dir': 'build'} 23:29:44 INFO - [mozharness: 2016-10-04 06:29:44.017018Z] Running clobber step. 23:29:44 INFO - Running pre-action listener: _resource_record_pre_action 23:29:44 INFO - Running main action method: clobber 23:29:44 INFO - rmtree: /builds/slave/test/build 23:29:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:29:44 INFO - Running post-action listener: _resource_record_post_action 23:29:44 INFO - [mozharness: 2016-10-04 06:29:44.478310Z] Finished clobber step (success) 23:29:44 INFO - [mozharness: 2016-10-04 06:29:44.478410Z] Running read-buildbot-config step. 23:29:44 INFO - Running pre-action listener: _resource_record_pre_action 23:29:44 INFO - Running main action method: read_buildbot_config 23:29:44 INFO - Using buildbot properties: 23:29:44 INFO - { 23:29:44 INFO - "project": "", 23:29:44 INFO - "product": "firefox", 23:29:44 INFO - "script_repo_revision": "production", 23:29:44 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 23:29:44 INFO - "repository": "", 23:29:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 23:29:44 INFO - "buildid": "20161003213045", 23:29:44 INFO - "pgo_build": "True", 23:29:44 INFO - "basedir": "/builds/slave/test", 23:29:44 INFO - "buildnumber": 1729, 23:29:44 INFO - "slavename": "talos-linux64-ix-067", 23:29:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:29:44 INFO - "platform": "ubuntu64_hw", 23:29:44 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 23:29:44 INFO - "branch": "mozilla-inbound", 23:29:44 INFO - "repo_path": "integration/mozilla-inbound", 23:29:44 INFO - "revision": "625a597ea7e3557d18487cf1616eb599f8ba34a2", 23:29:44 INFO - "stage_platform": "linux64-pgo", 23:29:44 INFO - "builduid": "050004a692aa4a1bb3fafeb04fc291f8", 23:29:44 INFO - "slavebuilddir": "test" 23:29:44 INFO - } 23:29:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:29:44 INFO - Running post-action listener: _resource_record_post_action 23:29:44 INFO - [mozharness: 2016-10-04 06:29:44.480823Z] Finished read-buildbot-config step (success) 23:29:44 INFO - [mozharness: 2016-10-04 06:29:44.480911Z] Running download-and-extract step. 23:29:44 INFO - Running pre-action listener: _resource_record_pre_action 23:29:44 INFO - Running main action method: download_and_extract 23:29:44 INFO - mkdir: /builds/slave/test/build/tests 23:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:44 INFO - trying https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:29:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:29:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:29:45 INFO - Downloaded 1361 bytes. 23:29:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:29:45 INFO - Using the following test package requirements: 23:29:45 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:29:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:29:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:29:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:29:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:29:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:29:45 INFO - u'jsshell-linux-x86_64.zip'], 23:29:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:29:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:29:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:29:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:29:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:29:45 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:29:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:29:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:29:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:29:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:29:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:29:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:29:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:29:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:29:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:29:45 INFO - Http code: 200 23:29:45 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 23:29:45 INFO - x-amz-cf-id: kV-2lojXYtAtXqKiKUkF_1J33Ar4I8n5xyvNQKZJVBjqxNMm8nej-g== 23:29:45 INFO - x-amz-version-id: SzYLsHHEALlygV6ggL55KULqWP163C.B 23:29:45 INFO - Expected file size: 21992701 23:29:45 INFO - Obtained file size: 21992701 23:29:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:29:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:29:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:29:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:29:50 INFO - Http code: 200 23:29:50 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 23:29:50 INFO - x-amz-cf-id: pD4j1p4QQGh6vBLfdZbvws0IT7HEgg3E9lQDIwS8VXKCV6vBaWR4CQ== 23:29:50 INFO - x-amz-version-id: SzYLsHHEALlygV6ggL55KULqWP163C.B 23:29:50 INFO - Expected file size: 21992701 23:29:50 INFO - Obtained file size: 21992701 23:29:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:29:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:29:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:29:55 INFO - Http code: 200 23:29:55 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 23:29:55 INFO - x-amz-cf-id: VxXoJam9nYwodQfIFcAcoqKgV07oGzQT0ECuJpIygls81NGmubz-RQ== 23:29:55 INFO - x-amz-version-id: KsUa6fmB3bngoQiaLNX7nFq4m8ICKT7Y 23:29:56 INFO - Expected file size: 14408522 23:29:56 INFO - Obtained file size: 14408522 23:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:56 INFO - trying https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:29:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:29:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:30:00 INFO - Downloaded 59687696 bytes. 23:30:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:30:00 INFO - mkdir: /builds/slave/test/properties 23:30:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:30:00 INFO - Writing to file /builds/slave/test/properties/build_url 23:30:00 INFO - Contents: 23:30:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:30:01 INFO - Running post-action listener: _resource_record_post_action 23:30:01 INFO - Running post-action listener: set_extra_try_arguments 23:30:01 INFO - [mozharness: 2016-10-04 06:30:01.199490Z] Finished download-and-extract step (success) 23:30:01 INFO - [mozharness: 2016-10-04 06:30:01.199715Z] Running populate-webroot step. 23:30:01 INFO - Running pre-action listener: _resource_record_pre_action 23:30:01 INFO - Running main action method: populate_webroot 23:30:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:30:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:30:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:30:01 INFO - '--tppagecycles', 23:30:01 INFO - '7'], 23:30:01 INFO - 'tests': ['tsvgm']}}, 23:30:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:30:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:30:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:30:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:30:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:01 INFO - 'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:30:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:30:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:01 INFO - 'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['damp', 'tps']}, 23:30:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:01 INFO - 'tests': ['damp', 'tps']}, 23:30:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['dromaeo_dom']}, 23:30:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:30:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['basic_compositor_video']}, 23:30:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:30:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['a11yr', 23:30:01 INFO - 'ts_paint', 23:30:01 INFO - 'tpaint', 23:30:01 INFO - 'sessionrestore', 23:30:01 INFO - 'sessionrestore_no_auto_restore', 23:30:01 INFO - 'tabpaint']}, 23:30:01 INFO - 'other-e10s': {'tests': ['a11yr', 23:30:01 INFO - 'ts_paint', 23:30:01 INFO - 'tpaint', 23:30:01 INFO - 'sessionrestore', 23:30:01 INFO - 'sessionrestore_no_auto_restore', 23:30:01 INFO - 'tabpaint']}, 23:30:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:30:01 INFO - 'ts_paint', 23:30:01 INFO - 'tpaint', 23:30:01 INFO - 'sessionrestore', 23:30:01 INFO - 'sessionrestore_no_auto_restore', 23:30:01 INFO - 'tabpaint']}, 23:30:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:30:01 INFO - 'ts_paint', 23:30:01 INFO - 'tpaint', 23:30:01 INFO - 'sessionrestore', 23:30:01 INFO - 'sessionrestore_no_auto_restore', 23:30:01 INFO - 'tabpaint']}, 23:30:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['a11yr', 23:30:01 INFO - 'ts_paint', 23:30:01 INFO - 'tpaint', 23:30:01 INFO - 'sessionrestore', 23:30:01 INFO - 'sessionrestore_no_auto_restore', 23:30:01 INFO - 'tabpaint']}, 23:30:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['a11yr', 23:30:01 INFO - 'ts_paint', 23:30:01 INFO - 'tpaint', 23:30:01 INFO - 'sessionrestore', 23:30:01 INFO - 'sessionrestore_no_auto_restore', 23:30:01 INFO - 'tabpaint']}, 23:30:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['tsvgx', 23:30:01 INFO - 'tsvgr_opacity', 23:30:01 INFO - 'tart', 23:30:01 INFO - 'tscrollx', 23:30:01 INFO - 'cart']}, 23:30:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:30:01 INFO - 'tsvgr_opacity', 23:30:01 INFO - 'tart', 23:30:01 INFO - 'tscrollx', 23:30:01 INFO - 'cart']}, 23:30:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:01 INFO - 'talos_options': ['--disable-e10s'], 23:30:01 INFO - 'tests': ['tp5o']}, 23:30:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:01 INFO - 'tests': ['tp5o']}, 23:30:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:01 INFO - 'talos_options': ['--disable-e10s', 23:30:01 INFO - '--xperf_path', 23:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:30:01 INFO - 'tests': ['tp5n']}, 23:30:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:01 INFO - 'talos_options': ['--xperf_path', 23:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:30:01 INFO - 'tests': ['tp5n']}}, 23:30:01 INFO - 'talos.zip': {'path': '', 23:30:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:30:01 INFO - Running post-action listener: _resource_record_post_action 23:30:01 INFO - [mozharness: 2016-10-04 06:30:01.218904Z] Finished populate-webroot step (success) 23:30:01 INFO - [mozharness: 2016-10-04 06:30:01.218992Z] Running create-virtualenv step. 23:30:01 INFO - Running pre-action listener: _resource_record_pre_action 23:30:01 INFO - Running main action method: create_virtualenv 23:30:01 INFO - Creating virtualenv /builds/slave/test/build/venv 23:30:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:30:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:30:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:30:01 INFO - Using real prefix '/usr' 23:30:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:30:01 INFO - Installing distribute.............................................................................................................................................................................................done. 23:30:03 INFO - Installing pip.................done. 23:30:03 INFO - Return code: 0 23:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:30:03 INFO - Reading from file tmpfile_stdout 23:30:03 INFO - Output received: 23:30:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 23:30:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:30:03 INFO - Using env: {'DISPLAY': ':0', 23:30:03 INFO - 'HOME': '/home/cltbld', 23:30:03 INFO - 'LANG': 'en_US.UTF-8', 23:30:03 INFO - 'LANGUAGE': 'en_US:en', 23:30:03 INFO - 'LOGNAME': 'cltbld', 23:30:03 INFO - 'MAIL': '/var/mail/cltbld', 23:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:03 INFO - 'MOZ_NO_REMOTE': '1', 23:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:03 INFO - 'NO_EM_RESTART': '1', 23:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:03 INFO - 'PWD': '/builds/slave/test', 23:30:03 INFO - 'SHELL': '/bin/bash', 23:30:03 INFO - 'SHLVL': '1', 23:30:03 INFO - 'TERM': 'linux', 23:30:03 INFO - 'TMOUT': '86400', 23:30:03 INFO - 'USER': 'cltbld', 23:30:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:04 INFO - '_': '/tools/buildbot/bin/python'} 23:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:30:04 INFO - Cleaning up... 23:30:04 INFO - Return code: 0 23:30:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:30:04 INFO - Using env: {'DISPLAY': ':0', 23:30:04 INFO - 'HOME': '/home/cltbld', 23:30:04 INFO - 'LANG': 'en_US.UTF-8', 23:30:04 INFO - 'LANGUAGE': 'en_US:en', 23:30:04 INFO - 'LOGNAME': 'cltbld', 23:30:04 INFO - 'MAIL': '/var/mail/cltbld', 23:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:04 INFO - 'MOZ_NO_REMOTE': '1', 23:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:04 INFO - 'NO_EM_RESTART': '1', 23:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:04 INFO - 'PWD': '/builds/slave/test', 23:30:04 INFO - 'SHELL': '/bin/bash', 23:30:04 INFO - 'SHLVL': '1', 23:30:04 INFO - 'TERM': 'linux', 23:30:04 INFO - 'TMOUT': '86400', 23:30:04 INFO - 'USER': 'cltbld', 23:30:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:04 INFO - '_': '/tools/buildbot/bin/python'} 23:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:04 INFO - Downloading/unpacking psutil>=3.1.1 23:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:30:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:30:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:30:06 INFO - Installing collected packages: psutil 23:30:06 INFO - Running setup.py install for psutil 23:30:06 INFO - building 'psutil._psutil_linux' extension 23:30:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:30:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:30:06 INFO - building 'psutil._psutil_posix' extension 23:30:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:30:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:30:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:30:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:30:06 INFO - Successfully installed psutil 23:30:06 INFO - Cleaning up... 23:30:06 INFO - Return code: 0 23:30:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:30:06 INFO - Using env: {'DISPLAY': ':0', 23:30:06 INFO - 'HOME': '/home/cltbld', 23:30:06 INFO - 'LANG': 'en_US.UTF-8', 23:30:06 INFO - 'LANGUAGE': 'en_US:en', 23:30:06 INFO - 'LOGNAME': 'cltbld', 23:30:06 INFO - 'MAIL': '/var/mail/cltbld', 23:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:06 INFO - 'MOZ_NO_REMOTE': '1', 23:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:06 INFO - 'NO_EM_RESTART': '1', 23:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:06 INFO - 'PWD': '/builds/slave/test', 23:30:06 INFO - 'SHELL': '/bin/bash', 23:30:06 INFO - 'SHLVL': '1', 23:30:06 INFO - 'TERM': 'linux', 23:30:06 INFO - 'TMOUT': '86400', 23:30:06 INFO - 'USER': 'cltbld', 23:30:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:06 INFO - '_': '/tools/buildbot/bin/python'} 23:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:30:09 INFO - Installing collected packages: mozsystemmonitor 23:30:09 INFO - Running setup.py install for mozsystemmonitor 23:30:09 INFO - Successfully installed mozsystemmonitor 23:30:09 INFO - Cleaning up... 23:30:09 INFO - Return code: 0 23:30:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:30:09 INFO - Using env: {'DISPLAY': ':0', 23:30:09 INFO - 'HOME': '/home/cltbld', 23:30:09 INFO - 'LANG': 'en_US.UTF-8', 23:30:09 INFO - 'LANGUAGE': 'en_US:en', 23:30:09 INFO - 'LOGNAME': 'cltbld', 23:30:09 INFO - 'MAIL': '/var/mail/cltbld', 23:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:09 INFO - 'MOZ_NO_REMOTE': '1', 23:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:09 INFO - 'NO_EM_RESTART': '1', 23:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:09 INFO - 'PWD': '/builds/slave/test', 23:30:09 INFO - 'SHELL': '/bin/bash', 23:30:09 INFO - 'SHLVL': '1', 23:30:09 INFO - 'TERM': 'linux', 23:30:09 INFO - 'TMOUT': '86400', 23:30:09 INFO - 'USER': 'cltbld', 23:30:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:09 INFO - '_': '/tools/buildbot/bin/python'} 23:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:09 INFO - Downloading/unpacking jsonschema==2.5.1 23:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:30:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:11 INFO - Downloading functools32-3.2.3-2.tar.gz 23:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:30:11 INFO - warning: no files found matching '*.txt' 23:30:11 INFO - no previously-included directories found matching 'build' 23:30:11 INFO - no previously-included directories found matching 'dist' 23:30:11 INFO - no previously-included directories found matching '.git*' 23:30:11 INFO - Installing collected packages: jsonschema, functools32 23:30:11 INFO - Running setup.py install for functools32 23:30:11 INFO - warning: no files found matching '*.txt' 23:30:11 INFO - no previously-included directories found matching 'build' 23:30:11 INFO - no previously-included directories found matching 'dist' 23:30:11 INFO - no previously-included directories found matching '.git*' 23:30:11 INFO - Successfully installed jsonschema functools32 23:30:11 INFO - Cleaning up... 23:30:11 INFO - Return code: 0 23:30:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:30:11 INFO - Using env: {'DISPLAY': ':0', 23:30:11 INFO - 'HOME': '/home/cltbld', 23:30:11 INFO - 'LANG': 'en_US.UTF-8', 23:30:11 INFO - 'LANGUAGE': 'en_US:en', 23:30:11 INFO - 'LOGNAME': 'cltbld', 23:30:11 INFO - 'MAIL': '/var/mail/cltbld', 23:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:11 INFO - 'MOZ_NO_REMOTE': '1', 23:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:11 INFO - 'NO_EM_RESTART': '1', 23:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:11 INFO - 'PWD': '/builds/slave/test', 23:30:11 INFO - 'SHELL': '/bin/bash', 23:30:11 INFO - 'SHLVL': '1', 23:30:11 INFO - 'TERM': 'linux', 23:30:11 INFO - 'TMOUT': '86400', 23:30:11 INFO - 'USER': 'cltbld', 23:30:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:11 INFO - '_': '/tools/buildbot/bin/python'} 23:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:30:12 INFO - Cleaning up... 23:30:12 INFO - Return code: 0 23:30:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:30:12 INFO - Using env: {'DISPLAY': ':0', 23:30:12 INFO - 'HOME': '/home/cltbld', 23:30:12 INFO - 'LANG': 'en_US.UTF-8', 23:30:12 INFO - 'LANGUAGE': 'en_US:en', 23:30:12 INFO - 'LOGNAME': 'cltbld', 23:30:12 INFO - 'MAIL': '/var/mail/cltbld', 23:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:12 INFO - 'MOZ_NO_REMOTE': '1', 23:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:12 INFO - 'NO_EM_RESTART': '1', 23:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:12 INFO - 'PWD': '/builds/slave/test', 23:30:12 INFO - 'SHELL': '/bin/bash', 23:30:12 INFO - 'SHLVL': '1', 23:30:12 INFO - 'TERM': 'linux', 23:30:12 INFO - 'TMOUT': '86400', 23:30:12 INFO - 'USER': 'cltbld', 23:30:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:12 INFO - '_': '/tools/buildbot/bin/python'} 23:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:12 INFO - Downloading/unpacking blobuploader==1.2.4 23:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:14 INFO - Downloading blobuploader-1.2.4.tar.gz 23:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:30:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:30:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:14 INFO - Downloading docopt-0.6.1.tar.gz 23:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:30:14 INFO - Installing collected packages: blobuploader, requests, docopt 23:30:14 INFO - Running setup.py install for blobuploader 23:30:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:30:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:30:15 INFO - Running setup.py install for requests 23:30:15 INFO - Running setup.py install for docopt 23:30:15 INFO - Successfully installed blobuploader requests docopt 23:30:15 INFO - Cleaning up... 23:30:15 INFO - Return code: 0 23:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:30:15 INFO - Using env: {'DISPLAY': ':0', 23:30:15 INFO - 'HOME': '/home/cltbld', 23:30:15 INFO - 'LANG': 'en_US.UTF-8', 23:30:15 INFO - 'LANGUAGE': 'en_US:en', 23:30:15 INFO - 'LOGNAME': 'cltbld', 23:30:15 INFO - 'MAIL': '/var/mail/cltbld', 23:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:15 INFO - 'MOZ_NO_REMOTE': '1', 23:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:15 INFO - 'NO_EM_RESTART': '1', 23:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:15 INFO - 'PWD': '/builds/slave/test', 23:30:15 INFO - 'SHELL': '/bin/bash', 23:30:15 INFO - 'SHLVL': '1', 23:30:15 INFO - 'TERM': 'linux', 23:30:15 INFO - 'TMOUT': '86400', 23:30:15 INFO - 'USER': 'cltbld', 23:30:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:15 INFO - '_': '/tools/buildbot/bin/python'} 23:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:30:15 INFO - Running setup.py (path:/tmp/pip-_PMjfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:30:15 INFO - Running setup.py (path:/tmp/pip-9xNJ1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:30:15 INFO - Running setup.py (path:/tmp/pip-ucRX_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:30:16 INFO - Running setup.py (path:/tmp/pip-kkxI7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:30:16 INFO - Running setup.py (path:/tmp/pip-JAOlO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:30:16 INFO - Running setup.py (path:/tmp/pip-0b9x0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:30:16 INFO - Running setup.py (path:/tmp/pip-2Bj2PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:30:16 INFO - Running setup.py (path:/tmp/pip-jLMPDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:30:16 INFO - Running setup.py (path:/tmp/pip-t7vv5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:30:16 INFO - Running setup.py (path:/tmp/pip-1opsib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:30:16 INFO - Running setup.py (path:/tmp/pip-DWOjug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:16 INFO - Running setup.py (path:/tmp/pip-nI0IlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:16 INFO - Running setup.py (path:/tmp/pip-ioRhhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:16 INFO - Running setup.py (path:/tmp/pip-TR0F52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:16 INFO - Running setup.py (path:/tmp/pip-Sd1LXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:16 INFO - Running setup.py (path:/tmp/pip-_W1fHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:16 INFO - Running setup.py (path:/tmp/pip-mdzmwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:30:17 INFO - Running setup.py install for manifestparser 23:30:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Running setup.py install for mozcrash 23:30:17 INFO - Running setup.py install for mozdebug 23:30:17 INFO - Running setup.py install for mozdevice 23:30:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Running setup.py install for mozfile 23:30:17 INFO - Running setup.py install for mozhttpd 23:30:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Running setup.py install for mozinfo 23:30:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Running setup.py install for mozInstall 23:30:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:30:17 INFO - Running setup.py install for mozleak 23:30:17 INFO - Running setup.py install for mozlog 23:30:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:30:18 INFO - Running setup.py install for moznetwork 23:30:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:30:18 INFO - Running setup.py install for mozprocess 23:30:18 INFO - Running setup.py install for mozprofile 23:30:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:30:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:30:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:30:18 INFO - Running setup.py install for mozrunner 23:30:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:30:18 INFO - Running setup.py install for mozscreenshot 23:30:18 INFO - Running setup.py install for moztest 23:30:18 INFO - Running setup.py install for mozversion 23:30:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:30:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:30:18 INFO - Cleaning up... 23:30:18 INFO - Return code: 0 23:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:30:18 INFO - Using env: {'DISPLAY': ':0', 23:30:18 INFO - 'HOME': '/home/cltbld', 23:30:18 INFO - 'LANG': 'en_US.UTF-8', 23:30:18 INFO - 'LANGUAGE': 'en_US:en', 23:30:18 INFO - 'LOGNAME': 'cltbld', 23:30:18 INFO - 'MAIL': '/var/mail/cltbld', 23:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:18 INFO - 'MOZ_NO_REMOTE': '1', 23:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:18 INFO - 'NO_EM_RESTART': '1', 23:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:18 INFO - 'PWD': '/builds/slave/test', 23:30:18 INFO - 'SHELL': '/bin/bash', 23:30:18 INFO - 'SHLVL': '1', 23:30:18 INFO - 'TERM': 'linux', 23:30:18 INFO - 'TMOUT': '86400', 23:30:18 INFO - 'USER': 'cltbld', 23:30:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:18 INFO - '_': '/tools/buildbot/bin/python'} 23:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:30:19 INFO - Running setup.py (path:/tmp/pip-RkUb7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:30:19 INFO - Running setup.py (path:/tmp/pip-ZobSRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:30:19 INFO - Running setup.py (path:/tmp/pip-SRlFfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:30:19 INFO - Running setup.py (path:/tmp/pip-uhNltP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:30:19 INFO - Running setup.py (path:/tmp/pip-tQDRnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:30:19 INFO - Running setup.py (path:/tmp/pip-w1n1pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:30:19 INFO - Running setup.py (path:/tmp/pip-RMaEnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:30:19 INFO - Running setup.py (path:/tmp/pip-rED8YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:30:19 INFO - Running setup.py (path:/tmp/pip-R5zq1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:30:19 INFO - Running setup.py (path:/tmp/pip-TUJj5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:30:19 INFO - Running setup.py (path:/tmp/pip-S2x47U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:19 INFO - Running setup.py (path:/tmp/pip-dIKhHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:19 INFO - Running setup.py (path:/tmp/pip-V64Zjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:20 INFO - Running setup.py (path:/tmp/pip-GHZgyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:20 INFO - Running setup.py (path:/tmp/pip-eFTq3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:20 INFO - Running setup.py (path:/tmp/pip-jAMdaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:20 INFO - Running setup.py (path:/tmp/pip-l4QAAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:30:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:22 INFO - Downloading blessings-1.6.tar.gz 23:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:30:22 INFO - Installing collected packages: blessings 23:30:22 INFO - Running setup.py install for blessings 23:30:22 INFO - Successfully installed blessings 23:30:22 INFO - Cleaning up... 23:30:22 INFO - Return code: 0 23:30:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:22 INFO - Reading from file tmpfile_stdout 23:30:22 INFO - Current package versions: 23:30:22 INFO - argparse == 1.2.1 23:30:22 INFO - blessings == 1.6 23:30:22 INFO - blobuploader == 1.2.4 23:30:22 INFO - docopt == 0.6.1 23:30:22 INFO - functools32 == 3.2.3-2 23:30:22 INFO - jsonschema == 2.5.1 23:30:22 INFO - manifestparser == 1.1 23:30:22 INFO - mozInstall == 1.12 23:30:22 INFO - mozcrash == 0.17 23:30:22 INFO - mozdebug == 0.1 23:30:22 INFO - mozdevice == 0.48 23:30:22 INFO - mozfile == 1.2 23:30:22 INFO - mozhttpd == 0.7 23:30:22 INFO - mozinfo == 0.9 23:30:22 INFO - mozleak == 0.1 23:30:22 INFO - mozlog == 3.4 23:30:22 INFO - moznetwork == 0.27 23:30:22 INFO - mozprocess == 0.23 23:30:22 INFO - mozprofile == 0.28 23:30:22 INFO - mozrunner == 6.12 23:30:22 INFO - mozscreenshot == 0.1 23:30:22 INFO - mozsystemmonitor == 0.3 23:30:22 INFO - moztest == 0.7 23:30:22 INFO - mozversion == 1.4 23:30:22 INFO - psutil == 3.1.1 23:30:22 INFO - requests == 1.2.3 23:30:22 INFO - wsgiref == 0.1.2 23:30:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:30:22 INFO - Using env: {'DISPLAY': ':0', 23:30:22 INFO - 'HOME': '/home/cltbld', 23:30:22 INFO - 'LANG': 'en_US.UTF-8', 23:30:22 INFO - 'LANGUAGE': 'en_US:en', 23:30:22 INFO - 'LOGNAME': 'cltbld', 23:30:22 INFO - 'MAIL': '/var/mail/cltbld', 23:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:22 INFO - 'MOZ_NO_REMOTE': '1', 23:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:22 INFO - 'NO_EM_RESTART': '1', 23:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:22 INFO - 'PWD': '/builds/slave/test', 23:30:22 INFO - 'SHELL': '/bin/bash', 23:30:22 INFO - 'SHLVL': '1', 23:30:22 INFO - 'TERM': 'linux', 23:30:22 INFO - 'TMOUT': '86400', 23:30:22 INFO - 'USER': 'cltbld', 23:30:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:22 INFO - '_': '/tools/buildbot/bin/python'} 23:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:30:22 INFO - Cleaning up... 23:30:22 INFO - Return code: 0 23:30:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f2c9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:30:22 INFO - Using env: {'DISPLAY': ':0', 23:30:22 INFO - 'HOME': '/home/cltbld', 23:30:22 INFO - 'LANG': 'en_US.UTF-8', 23:30:22 INFO - 'LANGUAGE': 'en_US:en', 23:30:22 INFO - 'LOGNAME': 'cltbld', 23:30:22 INFO - 'MAIL': '/var/mail/cltbld', 23:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:22 INFO - 'MOZ_NO_REMOTE': '1', 23:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:22 INFO - 'NO_EM_RESTART': '1', 23:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:22 INFO - 'PWD': '/builds/slave/test', 23:30:22 INFO - 'SHELL': '/bin/bash', 23:30:22 INFO - 'SHLVL': '1', 23:30:22 INFO - 'TERM': 'linux', 23:30:22 INFO - 'TMOUT': '86400', 23:30:22 INFO - 'USER': 'cltbld', 23:30:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:22 INFO - '_': '/tools/buildbot/bin/python'} 23:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:30:23 INFO - Cleaning up... 23:30:23 INFO - Return code: 0 23:30:23 INFO - Running post-action listener: _resource_record_post_action 23:30:23 INFO - Running post-action listener: _start_resource_monitoring 23:30:23 INFO - Starting resource monitoring. 23:30:23 INFO - [mozharness: 2016-10-04 06:30:23.186016Z] Finished create-virtualenv step (success) 23:30:23 INFO - [mozharness: 2016-10-04 06:30:23.186524Z] Running install step. 23:30:23 INFO - Running pre-action listener: _resource_record_pre_action 23:30:23 INFO - Running main action method: install 23:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:23 INFO - Reading from file tmpfile_stdout 23:30:23 INFO - Detecting whether we're running mozinstall >=1.0... 23:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:30:23 INFO - Reading from file tmpfile_stdout 23:30:23 INFO - Output received: 23:30:23 INFO - Usage: mozinstall [options] installer 23:30:23 INFO - Options: 23:30:23 INFO - -h, --help show this help message and exit 23:30:23 INFO - -d DEST, --destination=DEST 23:30:23 INFO - Directory to install application into. [default: 23:30:23 INFO - "/builds/slave/test"] 23:30:23 INFO - --app=APP Application being installed. [default: firefox] 23:30:23 INFO - mkdir: /builds/slave/test/build/application 23:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:30:40 INFO - Reading from file tmpfile_stdout 23:30:40 INFO - Output received: 23:30:40 INFO - /builds/slave/test/build/application/firefox/firefox 23:30:40 INFO - Running post-action listener: _resource_record_post_action 23:30:40 INFO - [mozharness: 2016-10-04 06:30:40.492635Z] Finished install step (success) 23:30:40 INFO - [mozharness: 2016-10-04 06:30:40.492881Z] Running run-tests step. 23:30:40 INFO - Running pre-action listener: _resource_record_pre_action 23:30:40 INFO - Running main action method: run_tests 23:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:30:40 INFO - Python 2.7.3 23:30:40 INFO - Return code: 0 23:30:40 INFO - grabbing minidump binary from tooltool 23:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f63d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f641d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:30:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:30:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:30:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:30:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:30:40 INFO - Return code: 0 23:30:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:30:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:30:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:30:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:30:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:30:40 INFO - Using env: {'DISPLAY': ':0', 23:30:40 INFO - 'HOME': '/home/cltbld', 23:30:40 INFO - 'LANG': 'en_US.UTF-8', 23:30:40 INFO - 'LANGUAGE': 'en_US:en', 23:30:40 INFO - 'LOGNAME': 'cltbld', 23:30:40 INFO - 'MAIL': '/var/mail/cltbld', 23:30:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:30:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:40 INFO - 'MOZ_NO_REMOTE': '1', 23:30:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:40 INFO - 'NO_EM_RESTART': '1', 23:30:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:40 INFO - 'PWD': '/builds/slave/test', 23:30:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:30:40 INFO - 'SHELL': '/bin/bash', 23:30:40 INFO - 'SHLVL': '1', 23:30:40 INFO - 'TERM': 'linux', 23:30:40 INFO - 'TMOUT': '86400', 23:30:40 INFO - 'USER': 'cltbld', 23:30:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287', 23:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:40 INFO - '_': '/tools/buildbot/bin/python'} 23:30:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:30:40 INFO - mozversion application_buildid: 20161003213045 23:30:40 INFO - mozversion application_changeset: 625a597ea7e3557d18487cf1616eb599f8ba34a2 23:30:40 INFO - mozversion application_display_name: Nightly 23:30:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:30:40 INFO - mozversion application_name: Firefox 23:30:40 INFO - mozversion application_remotingname: firefox 23:30:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:30:40 INFO - mozversion application_vendor: Mozilla 23:30:40 INFO - mozversion application_version: 52.0a1 23:30:40 INFO - mozversion platform_buildid: 20161003213045 23:30:40 INFO - mozversion platform_changeset: 625a597ea7e3557d18487cf1616eb599f8ba34a2 23:30:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:30:40 INFO - mozversion platform_version: 52.0a1 23:30:40 INFO - using testdate: 1475562640 23:30:40 INFO - actual date: 1475562640 23:30:40 INFO - starting webserver on 'localhost:44144' 23:30:40 INFO - SUITE-START | Running 2 tests 23:30:40 INFO - TEST-START | dromaeo_css 23:30:40 INFO - operating with platform_type : linux_ 23:30:40 INFO - Initialising browser for dromaeo_css test... 23:30:40 INFO - TEST-INFO | started process 15005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVM8A6V/profile http://localhost:44144/getInfo.html) 23:30:45 INFO - PROCESS | 15005 | __metrics Screen width/height:1600/1200 23:30:45 INFO - PROCESS | 15005 | colorDepth:24 23:30:45 INFO - PROCESS | 15005 | Browser inner width/height: 1024/697 23:30:45 INFO - PROCESS | 15005 | __metrics 23:30:45 ERROR - PROCESS | 15005 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 23:30:46 INFO - TEST-INFO | 15005: exit 0 23:30:46 INFO - Browser initialized. 23:30:46 INFO - Running cycle 1/1 for dromaeo_css test... 23:30:46 INFO - TEST-INFO | started process 15127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVM8A6V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:30:58 INFO - PROCESS | 15127 | RSS: Main: 185339904 23:30:58 INFO - PROCESS | 15127 | 23:31:48 INFO - PROCESS | 15127 | 1475562708158 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:33:58 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44144/tests/dromaeo/cssquery-ext.html) 23:33:59 INFO - PROCESS | 15127 | RSS: Main: 202301440 23:33:59 INFO - PROCESS | 15127 | 23:37:01 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-ext.html (next: http://localhost:44144/tests/dromaeo/cssquery-jquery.html) 23:37:02 INFO - PROCESS | 15127 | RSS: Main: 201613312 23:37:02 INFO - PROCESS | 15127 | 23:40:04 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44144/tests/dromaeo/cssquery-mootools.html) 23:40:05 INFO - PROCESS | 15127 | RSS: Main: 198569984 23:40:05 INFO - PROCESS | 15127 | 23:43:06 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44144/tests/dromaeo/cssquery-prototype.html) 23:43:07 INFO - PROCESS | 15127 | RSS: Main: 195145728 23:43:07 INFO - PROCESS | 15127 | 23:46:10 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44144/tests/dromaeo/cssquery-yui.html) 23:46:10 INFO - PROCESS | 15127 | RSS: Main: 199274496 23:46:10 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:44144/tests/dromaeo/cssquery-yui.html (next: http://localhost:44144/tests/dromaeo/cssquery-dojo.html) 23:49:13 INFO - PROCESS | 15127 | RSS: Main: 199372800 23:49:13 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | __start_tp_report 23:49:13 INFO - PROCESS | 15127 | _x_x_mozilla_page_load 23:49:13 INFO - PROCESS | 15127 | _x_x_mozilla_page_load_details 23:49:13 INFO - PROCESS | 15127 | |i|pagename|runs| 23:49:13 INFO - PROCESS | 15127 | |0;dojo.html;3037.438073956318;3071.2168397058745;3085.72228499435;3091.8608662610195;3096.1949893027822;5180.559652429539;5315.14957606783;5332.893342133159;5387.622866399349;5437.265969094171;5233;5254.343207099113;5294.338207724035;5318.414974352818;5344.706041167734;4745.050989802036;4832.323474713543;4844.636652251095;4864.805407783702;4881.707097574139;4897.216445368742;4915.754212289389;4920.917398172396;4951.752412379385;4983.028309479653;4719.221328480797;4763.214069678499;4770.165221086296;4830.782614782325;4834.250691142878;4781.760911954389;4794.208955522335;4800.591949684281;4843.564079232886;4862.440819305754;4723.149833030053;4730.739809310487;4759.309900064506;4773.355596994396;4805.399325084364;5227.764750586195;5241.764120614582;5281.603879709037;5324.520793128599;5347.171188465794;5565.3599836018975;5611.7474713637985;5615.354234263071;5663.320401551799;5717.9714101429645;5668.178114173463;5675.290588676416;5677.148427735831;5682.659040457585;5692.1461780733225;5192.714400707921;5302.09864323066;5305.681659100466;5352.999999999961;5380.273663055437;5655.688937108499;5721.885562288731;5740.167675687002;5746.310442746813;5824.650520968756;5524.58565607573;5533.3083364579425;5538.75075621598;5542.667439953616;5569.470900264469;5387.218853266255;5567.944320556742;5571.498565129158;5621.662700237999;5647.6893770843;5397.514223719884;5519.448055194448;5542.11326187808;5543.556515478752;5636.774529018793;5505.449455054462;5520.337559492887;5520.66875987442;5533.280673512418;5569.081101618269;4322.7190232634775;4345.391645169679;4352.086061926968;4394.780260986938;4396.296592545242;3851.0372406898277;3880.3403421418425;3883.436901649245;3911.100446897173;3924.7448915820382;5348.465153484698;5384.838454846361;5387.703676297763;5397.136458166675;5444.373897001817;5628.690422026828;5656.490915817596;5673.8297851064535;5699.2590963174525;5699.544036477072;5271.894562108736;5275.736213189325;5303.920441193385;5366.034113859465;5407.270018547446;4871.8294859679745;4874.805007799649;4886.706797592155;4918.532739389752;4923.359963204761;5716.142578613241;5748.396418376094;5754.395788442153;5758.174498239528;5824.388439213822;5607.691576963306;5613.46672066153;5617.634853734494;5634.464725851038;5668.914966275427;5806.274215723035;5863.20846685692;5874.03078492044;5929.792457263975;5943.494802941798;5551.417101204477;5578.079616863334;5584.966781145501;5595.692236927008;5599.552035837041;5488.4237155098135;5532.944670553243;5685.800996965087;5686.829395118153;5702.116171993348;5411.729413529387;5455.427180146186;5457.126859702428;5462.590305727166;5464.316960379952;5444.754986025559;5449.073657478159;5449.155380915964;5450.972745136408;5451.4276001019325;5383.81156659515;5386.784528618811;5400.459954004568;5437.619366644455;5459.399466058651;5627.296587926509;5633.718314084197;5634.774609015593;5642;5644.745986430703;5497.945020549743;5511.862203444946;5512.448755124456;5514.255575497256;5517 23:49:13 INFO - PROCESS | 15127 | |1;ext.html;563.6871536297353;566.0603398358725;572.9255196824412;588.7174156404927;591.3377017740132;45483;48088.759556202254;48320;48472.75763621177;48541.51458485414;44734.32898506517;45388.3191752124;45444.318335225;45471;45607.31589026159;8975.596098175582;9130.406523575946;9133.543322833864;9135.68025119121;9157;8948.64205431782;9001.909980900173;9041.547922603877;9052.954735226314;9054.728358149267;9063.048379920112;9093.454392736458;9100.681476148337;9122.361434699573;9130.132637399436;8984.146506081945;8996.145366190201;8999.280057595377;9013.414128081686;9044.502552359618;8875.334349923716;8905.465672059698;8936.597853096626;9000.189982901571;9014.459132452008;42561.36157957633;42921.57078429207;42943.35584966228;43124.35313470301;43317;3454.5336379588684;3456.792592444436;3533.8586456541707;3539.132912436444;3619.7285203609836;31688.524672129937;31742.523862141854;32261.677383226335;33501.83249083763;33630.32739345224;4271.359296105609;4343.370211319372;4396.714213576107;4466.196084704752;4477.820887164509;345080;345589;345687;345984;346718.9999999975;59909;60232.39767602268;60238;60486.69756651277;60506.39493605096;56666;56869;57039.14441283384;57042.42957570454;57198.42801572014;15993.200339982954;16035.599110022109;16040.278187481592;16099.75850362222;16198.75701864473;10658.253922225525;10719.19606029551;10884.945575272073;10900.781984360268;10975.341479511255;16750;17030.74453883193;17222.224999875034;17229.56926076858;17473;5775.451332123442;5804.4195580442465;5966.164736936832;5989.371116032841;5993.520518358521;947.8293907096651;981.0777868803302;1052.652624633869;1107.5680484611007;1133.3086817041599;30969.8451507741;31249.8437507811;31270.374592508022;31740.365192696478;31769.8411507941;1010.4947526236881;1076.4187338837096;1093.2893619147617;1126.8366086917351;1167.2762887009937;16981.915090424467;17009.744853827204;17056.914715426345;17071.402500912656;17134.914325428294;457595;457620;458282;459264;460880;56300.71849640726;57339.13991290134;57587;57618.711906441036;57694.76883698588;1318.373772458094;1342.8992825537928;1356.2608378433777;1362.2507620808515;1375.6629625741557;29960.400791984473;30834.69165308318;31590.81723788659;31897.202569935936;31921;50911.74544127256;51286.743566281926;51394.74302628463;51485.227721583455;51516;404153.979230102;404703;405924;407913;407913;40236.1952760949;40541;40651;40881;41036.58963410328;46879.53120468752;47229.2915606273;47654.28518572155;48433.27350089681;49234.75382623064;39703.60296396999;40430.59569404386;40822.59177408307;42187.78906105573;42229.57770422257;40528.3920741195;40563.18873622452;41151.38272925968;41267.38098928458;41634.79182604067;40013;40823.59176408317;40933.38599921063;40964;43455.13089738251;31071.84464077665;35607.28785424329;36871.26257474889;37502.43746343862;37638.059048524;27131.1860644181;27404.177874663794;27627.171184864485;27757.30606734767;27928.720712792612 23:49:13 INFO - PROCESS | 15127 | |2;jquery.html;400.9518857737072;402.31606269342115;402.3341370032597;402.86101295053203;423.34170365082286;18221.544461388472;19707.11317990692;19753.20987160512;19825.40523784287;20502.282420115298;18647.25410983559;19089.904550477262;19206.135723892425;19224.327148549804;19523.804761952375;5604.075327570946;5646.378898321202;5832.883342333151;5863.179154918314;5874.676892770896;5745.712714364286;5769.451902069297;5780.855478613026;5822.097574875901;5845.415458454142;5519.503244707976;5769.336526299488;5772.220750198732;5780.248567686216;5782.913256301159;5607.775688972436;5766.279215098113;5773.826785196451;5776.480116789488;5777.075667893117;5060.74696265189;5067.189249720027;5125.077486052509;5133.486651334837;5139.665921715114;22939.77060229393;23330.300090997298;23378;23418.648720269208;23554.175603853953;2379.5121999990133;2428.562858685436;2430.5989511730545;2555.1567982565894;2564.8204625676212;13868.583942481742;14139.363728632236;14304.856951430456;14525.983181177322;15307;1895.5355937795327;1975.101328895349;2014.8085931836451;2059.073416962358;2063.0509965415927;75681.24318756851;78072;79223.6038819808;81025.59487202526;81061.59469202616;9271.258299336037;9799.11807937289;9805.558749856273;10346.32748871321;10453.163746900229;11944.522219111312;13152.934235328763;13254.40355184019;13339.466421343232;13392.464301428028;5679.460451257124;5744.741486633112;6392.616443013434;7455.701771929171;7719.575423351769;7376.3160393149665;7414.6292685365515;7559.395248380117;7601.429892757955;7660.731874384482;4072.837086516506;4193.832246710159;4196.475440569929;4206.453161089039;4271.9359209611885;1891.564940063793;1925.6218570065957;1967.9508012299807;2012.1146695453954;2064.977835971204;836.2139588786521;919.5218486387041;935.1770442010986;938.4791440750449;1050.6217761605815;18592.81407185911;19582;19750.70373944392;19891.233847228574;19922.103505342293;972.8735264415723;986.7631768375538;1001.7746007148334;1027.845823126537;1034.2966782587762;10194.388336699822;11084.667459976214;11085.27945683528;11109.333439993627;11133.165012624086;380996.1854386781;388400;475140;482264;486058;89709;91029;91636;93897.530512347;94684.52657736804;979.0747743382435;1007.8790545134631;1024.2625309777097;1073.8120828855076;1074.8817630060687;16544.917275413547;16799.91600041992;17377.91311043437;17481.47555573335;17767.289308427517;40391.798041009606;40600.59399405968;40887.591124089566;41630.37554436747;42774;57193.714031429576;57763.422365777486;58144.418555815595;58449.12326315194;58955;6816.318368163343;7043.542169758949;7512.32389084985;7516.098068231847;7834.843303133792;10535.262531623019;10727.892721072689;11412.372319522174;12949.935250323688;12970;10880.564777408816;11411.201215914807;11679.708007299545;11850.170488065753;12146.453409596767;10517.737056573647;10557.472126393803;11244.26912250701;11347.730453909086;11765.11761617865;10598.89401105979;10977.890221098007;11332.773344533229;11441.771164576496;11951.521939122338;8381.790455238668;8448.324134069137;8485.448445851247;8583.613737381707;8646.654133834576;9124.31567632417;10202.795944081225;10625.734356641145;10839.512221949873;10886.29239099456 23:49:13 INFO - PROCESS | 15127 | |3;mootools.html;1447.9348429320682;1481.8369979302274;1584.564244832671;1688.77324680115;1711.9058451785163;7376.262373762621;7647.158812530617;7705.113911900133;8231.259186673205;8259.380546459017;7981.720639777609;8228.341732661387;8269.958650206741;8386.496810191393;8408.495490270589;2298.276043046443;2309.642005489152;2330.1960823515947;2334.171369163948;2338.766123387656;2172.7827217278223;2203.8236941044756;2244.1920908472935;2245.045855511409;2249.741279752833;2283.1438210671;2299.9310020699404;2305.8616483010987;2323.186884590397;2326.255598208574;2253.5718213539376;2254.222293308814;2255.3008567344177;2266.9206577769783;2269.931902042933;2192.6162921488835;2221.1892659179284;2223.321886824518;2223.377454312795;2240.7423146338215;8085.070216925012;8266.875996860052;8302.294304984083;8382.203690649378;8420.578971051484;4687.742174180418;4821.93917338185;4833.178359678828;4837.4920633333695;4872.805087796484;3229.450993331116;3259.3318369734147;3414.453687410027;3414.5561077059824;3423.726101911866;1163.0927876256533;1175.7530918507123;1185.8161984892356;1200.6218041316956;1214.6113243762;11185.384803835786;11230.94384528072;11260.887391126065;11329.320240785579;11346;4212.662986961036;4346.065595896897;4429.313456414261;4457.108578284357;4543;9402.95298523503;9405;9416.71749847492;9443.527823608929;9450.716478505656;4984.4267909190185;4990.2764099205415;4993.375828021497;5004.174311238605;5033.823816166417;4174.533249423088;4176.540580536139;4593.150267200579;4621.861344159681;4622.237330840374;3713.814309284525;3800.600936901641;3814.885553433346;3852.9229415412096;3894.5131858517684;1260.5588044184644;1273.866244044362;1279.251637791902;1279.8720127987126;1299.1166007115064;933.6545478173119;942.4062840410497;948.990510094904;950.6387572722322;951.757301888028;5397.946020539823;5399.325084364455;5523.4200408956485;5665.9716701417055;5777.508911742465;443.1933880337754;446.75205261079765;447.34910704924255;450.6507456721067;453.77991674038066;3747.3442147624055;3765.1904840459433;3800.4299355096405;3889.766614003169;3895.3962135868987;9439.386439881524;9783.706488805346;10054.145397641136;10091;10096.394216347042;9799.118079372749;9839.901600983898;9886.209103271722;9898.752531186778;9900.108990190773;7452.366548843409;7634.6182690865235;7678.731244406419;7759.612019399007;7794.883076753853;5182.144946083854;5219.321488206509;5266.078436273713;5405.621606487508;5469.671819690831;9230.907690923004;9276.397034192756;9336.766580835261;9358.4384936904;9386.342955993015;8996.325275604226;9473.857892131762;9502.85745713801;9512.95243523778;9726.36778609388;6594.670266486753;6817.795466136024;7076;7108.466864985044;7195.784126476214;8015.799605009922;8049.678012879419;8170.714025009096;8173.959130204311;8175.182481751777;7187.7843664690145;7315.6342182889575;7388.7808511594985;7423.5917024562;7447.515911465737;7008.719651214098;7019.403350715246;7108.964455177691;7253.673584688807;7338.046054013158;6546.607203567801;6554.14796076507;6596.835079122869;6604.3725846044545;6613.66931653425;4747.786349614206;4839.612830973443;4866.464688884149;4949.430815456269;4951.678140920829;4706.952930470651;4727.456342520654;4813.4945830687275;4826.975865120652;4928.137575924271 23:49:13 INFO - PROCESS | 15127 | |4;prototype.html;323.5147279081378;325.8110296028304;331.36212790378517;337.28159021284654;339.5907930943214;5396;5447.509724124828;5510.311211098613;5519.482142410839;5573.600103936596;5433.532946104549;5437.809676661318;5457.844151560132;5475.151351540508;5484.61607687462;4252.639784919361;4266;4268.167707297078;4268.551802060785;4282.29342158545;4033.5966403359575;4239;4297.505786834523;4308.2029824482415;4314.654827613799;4212.894677633053;4227.154569086195;4227.915441691164;4229.450171477703;4230.280852255124;4153.902279348939;4218.135282267143;4221.134667393208;4232.555581663943;4234.216669916075;3717.8141092945243;3731.9253614927547;3736.23407201523;3738;3741.345264578688;5191.454897235773;5270.130428479335;5297.020051290524;5332.733363331818;5337.199420086979;4788.257820037899;4801.783919723586;4807.375041244651;4808.807647694123;4823.397075365579;5407.999520088757;5622.156676498558;5622.859428514279;5639.520640745542;5692.9146062809095;4002.239574480839;4040.5353384360883;4045.615666511677;4046.4941882264716;4063.329550624173;5854.97072514639;5868.889488571064;5885.411458854123;5896.498797602209;5903.940960590382;4099.672026237894;4110.77390743506;4115.32097203964;4118.897027574335;4122.42286079949;3978;4175.394567787654;4189.979050104791;4202.117555313357;4203.222403855297;4786.44955830084;4803.759812009385;4814.15752243363;4822.132016237041;4822.397200349957;5697.230873832063;5699.373068962411;5722.456366645162;5724.484796368263;5762.971185144132;1402.6212922510865;1437.6549628089183;1447.5440236325524;1451.2163431746737;1453.716525277582;901.4411065139656;916.6058594804298;918.6830543462495;929.7768535551419;932.7341707613298;4657.439757681214;4762.3570817939135;4764.690295130806;4782.928256076161;4792.976035119872;5022.744313921519;5040.874657712242;5041.42023667283;5047.848564543069;5051.696898186121;4534.614557762561;4778.976105119452;4786;4789.473157952622;4816.0622020567425;2690.9327266818486;2696.7303269672875;2708.404151086758;2710.7289271072736;2715.4297597504747;5186.066508028591;5188.688678679291;5251.8161864335325;5258.7370631468275;5258.765858996766;4886.3403440535785;5135.35808023997;5141.717205553656;5165.560927321219;5215.6609820361555;5182.792688292501;5211.973940130275;5224.499585277873;5246.790128394974;5295.4969277918535;5059.46875578059;5090.2364645303505;5098.311727916684;5106.897862042664;5114.9232761507865;4749.715017098985;4925.359703238556;4980.900381992267;5060.291559181791;5065.39215294167;5207.869803254949;5236.633435659467;5238.869028274171;5245.8229834618205;5270.578353731616;3774.943375849419;3780.527434070741;3968.9206215876097;4044.130511939947;4104.589541045872;5733.455321744427;5766.365699773106;5795.565332600157;5803.448672376117;5813.82558523245;5666.546676265806;5671.512020107687;5682.289713785777;5693.971530142323;5709.800156994485;5525.530329922001;5626.409227031267;5627.212190293444;5640;5645.40723224072;5559.777608895761;5574.804881829116;5581.246531718329;5588.916166257428;5594.636348637326;5481.808136715196;5652.3217213934595;5669.914951275817;5684;5699.287589051369;5580.190872323572;5608.186812912187;5611.971940140274;5622.409646987171;5628.437156284503 23:49:13 INFO - PROCESS | 15127 | |5;yui.html;686.296546040309;762.9852296445728;764.373213964549;797.6171437709895;838.9370797190209;16146.111963841984;16928.661426771487;16942.915285423587;17037.744433833486;17072.06103664298;15057.17185554794;15287;15306.770398444032;15338.539843804676;15390;779.9961000195005;786.2294950948075;789.656499422753;798.2895223251311;800.6077022259109;803.1366281247653;804.0913767442811;805.0259186384482;805.0540614777642;805.2873207211601;850.7617866997251;852.4160949749441;853.0786750309651;853.5476197615274;853.7182729699215;844.9028361738386;845.4124383553464;845.4927043773748;846.6105591427951;847.0851480401183;626.5488848029412;627.087587560099;627.1408170806025;627.9058141278799;628.1990462160736;14056.297185140702;14064;14098.929505352407;14102.083364581373;14103.294835258299;12768.233905965672;12772.744545109046;13178.53875114376;13422.194668319835;13773.793393099111;11428;11471.082313414907;11528.020118289955;11745.177837551375;12199.20705154171;3797.3354662933875;3872.5546562145432;3892.8637497687446;4034.394840773878;4044.4337792709043;78112.60943695302;78379.60810195969;78942;83323.99999999939;83853.16146838515;9788.168005719452;9964.352317099365;9969.003099689973;10003.599856005678;10308.896911030944;20321.89839050795;20351.69472457914;20365;20405.285814996405;20423.897880510503;7595.126560445509;8175.100738918714;8452.61963211657;8753.781155471164;8835.514046727363;4563.634909207255;4592.357070010201;4646.3495110684535;4690.226112691436;4716.198246298138;3289.8190599517256;3427.622961474236;3442.535257740223;3443.9311213776086;3461.3423449545007;638.2787450181265;675.6250281093942;683.5181197255922;685.540687739216;698.27728301208;617.299365220478;627.4039662320722;655.2693746472744;659.222117900872;682.3619915379037;9733.902660973441;9899.455529945779;10120.696379108638;10133.64532241368;10197.847032294521;611.7002668692309;627.2817623820699;636.5257882877286;691.7025678958096;751.4739682222466;4693.78877950493;4813.15769740294;4900.142475066849;4949.1586430306215;4963.379577552806;78885;118665.36799780122;122920;125874;126585.3670731659;83061;83297.3340533186;83418.58290708507;107900;107958;50606.49393506091;52210.21684674733;53900.46099539033;61343.6932815342;77304.84042739363;9258.907410925805;9315.487648179414;9500;9859.507024648596;10220.182385409;34710.47934281038;36646.633533664324;47887.28169077397;51476.48523514717;52263;72333.638331808;72373.27626723665;73357;73672;74306.62846685732;11839.1712580122;11941.16411851162;12350.135490515577;12395.588213345762;12509.311987840756;14208;14308.284585770878;14529.418823246951;14550.490732824725;15098.924505377403;13312.600621981355;13520.18878867271;13831.515896943558;14262.71474570482;14290.071145375518;13110.606681799562;13721.794173087212;13979.650508737363;14343;14451.78322325187;13035.348232588522;13519.256440895846;13608.591742247749;13847.376868040761;13893.58319250424;10170.898291016994;10430.37417754937;10454.163666906781;10638.89361106379;10691.358518488916;9990.300678952404;11215.527667083024;11407.828882566602;11730.706732331419;11773.411329433322 23:49:13 INFO - PROCESS | 15127 | __end_tp_report 23:49:13 INFO - PROCESS | 15127 | __start_cc_report 23:49:13 INFO - PROCESS | 15127 | _x_x_mozilla_cycle_collect,291 23:49:13 INFO - PROCESS | 15127 | __end_cc_report 23:49:13 INFO - PROCESS | 15127 | __startTimestamp1475563753752__endTimestamp 23:49:13 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | ------- Summary: start ------- 23:49:13 INFO - PROCESS | 15127 | Number of tests: 6 23:49:13 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | [#0] dojo.html Cycles:165 Average:5245.25 Median:5444.75 stddev:578.28 (10.6%) stddev-sans-first:553.50 23:49:13 INFO - PROCESS | 15127 | Values: 3037.4 3071.2 3085.7 3091.9 3096.2 5180.6 5315.1 5332.9 5387.6 5437.3 5233.0 5254.3 5294.3 5318.4 5344.7 4745.1 4832.3 4844.6 4864.8 4881.7 4897.2 4915.8 4920.9 4951.8 4983.0 4719.2 4763.2 4770.2 4830.8 4834.3 4781.8 4794.2 4800.6 4843.6 4862.4 4723.1 4730.7 4759.3 4773.4 4805.4 5227.8 5241.8 5281.6 5324.5 5347.2 5565.4 5611.7 5615.4 5663.3 5718.0 5668.2 5675.3 5677.1 5682.7 5692.1 5192.7 5302.1 5305.7 5353.0 5380.3 5655.7 5721.9 5740.2 5746.3 5824.7 5524.6 5533.3 5538.8 5542.7 5569.5 5387.2 5567.9 5571.5 5621.7 5647.7 5397.5 5519.4 5542.1 5543.6 5636.8 5505.4 5520.3 5520.7 5533.3 5569.1 4322.7 4345.4 4352.1 4394.8 4396.3 3851.0 3880.3 3883.4 3911.1 3924.7 5348.5 5384.8 5387.7 5397.1 5444.4 5628.7 5656.5 5673.8 5699.3 5699.5 5271.9 5275.7 5303.9 5366.0 5407.3 4871.8 4874.8 4886.7 4918.5 4923.4 5716.1 5748.4 5754.4 5758.2 5824.4 5607.7 5613.5 5617.6 5634.5 5668.9 5806.3 5863.2 5874.0 5929.8 5943.5 5551.4 5578.1 5585.0 5595.7 5599.6 5488.4 5532.9 5685.8 5686.8 5702.1 5411.7 5455.4 5457.1 5462.6 5464.3 5444.8 5449.1 5449.2 5451.0 5451.4 5383.8 5386.8 5400.5 5437.6 5459.4 5627.3 5633.7 5634.8 5642.0 5644.7 5497.9 5511.9 5512.4 5514.3 5517.0 23:49:13 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | [#1] ext.html Cycles:180 Average:57421.69 Median:42208.68 stddev:107116.27 (253.8%) stddev-sans-first:107331.69 23:49:13 INFO - PROCESS | 15127 | Values: 563.7 566.1 572.9 588.7 591.3 45483.0 48088.8 48320.0 48472.8 48541.5 44734.3 45388.3 45444.3 45471.0 45607.3 8975.6 9130.4 9133.5 9135.7 9157.0 8948.6 9001.9 9041.5 9053.0 9054.7 9063.0 9093.5 9100.7 9122.4 9130.1 8984.1 8996.1 8999.3 9013.4 9044.5 8875.3 8905.5 8936.6 9000.2 9014.5 42561.4 42921.6 42943.4 43124.4 43317.0 3454.5 3456.8 3533.9 3539.1 3619.7 31688.5 31742.5 32261.7 33501.8 33630.3 4271.4 4343.4 4396.7 4466.2 4477.8 345080.0 345589.0 345687.0 345984.0 346719.0 59909.0 60232.4 60238.0 60486.7 60506.4 56666.0 56869.0 57039.1 57042.4 57198.4 15993.2 16035.6 16040.3 16099.8 16198.8 10658.3 10719.2 10884.9 10900.8 10975.3 16750.0 17030.7 17222.2 17229.6 17473.0 5775.5 5804.4 5966.2 5989.4 5993.5 947.8 981.1 1052.7 1107.6 1133.3 30969.8 31249.8 31270.4 31740.4 31769.8 1010.5 1076.4 1093.3 1126.8 1167.3 16981.9 17009.7 17056.9 17071.4 17134.9 457595.0 457620.0 458282.0 459264.0 460880.0 56300.7 57339.1 57587.0 57618.7 57694.8 1318.4 1342.9 1356.3 1362.3 1375.7 29960.4 30834.7 31590.8 31897.2 31921.0 50911.7 51286.7 51394.7 51485.2 51516.0 404154.0 404703.0 405924.0 407913.0 407913.0 40236.2 40541.0 40651.0 40881.0 41036.6 46879.5 47229.3 47654.3 48433.3 49234.8 39703.6 40430.6 40822.6 42187.8 42229.6 40528.4 40563.2 41151.4 41267.4 41634.8 40013.0 40823.6 40933.4 40964.0 43455.1 31071.8 35607.3 36871.3 37502.4 37638.1 27131.2 27404.2 27627.2 27757.3 27928.7 23:49:13 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | [#2] jquery.html Cycles:180 Average:27454.25 Median:194400.48 stddev:73696.39 (37.9%) stddev-sans-first:73875.14 23:49:13 INFO - PROCESS | 15127 | Values: 401.0 402.3 402.3 402.9 423.3 18221.5 19707.1 19753.2 19825.4 20502.3 18647.3 19089.9 19206.1 19224.3 19523.8 5604.1 5646.4 5832.9 5863.2 5874.7 5745.7 5769.5 5780.9 5822.1 5845.4 5519.5 5769.3 5772.2 5780.2 5782.9 5607.8 5766.3 5773.8 5776.5 5777.1 5060.7 5067.2 5125.1 5133.5 5139.7 22939.8 23330.3 23378.0 23418.6 23554.2 2379.5 2428.6 2430.6 2555.2 2564.8 13868.6 14139.4 14304.9 14526.0 15307.0 1895.5 1975.1 2014.8 2059.1 2063.1 75681.2 78072.0 79223.6 81025.6 81061.6 9271.3 9799.1 9805.6 10346.3 10453.2 11944.5 13152.9 13254.4 13339.5 13392.5 5679.5 5744.7 6392.6 7455.7 7719.6 7376.3 7414.6 7559.4 7601.4 7660.7 4072.8 4193.8 4196.5 4206.5 4271.9 1891.6 1925.6 1968.0 2012.1 2065.0 836.2 919.5 935.2 938.5 1050.6 18592.8 19582.0 19750.7 19891.2 19922.1 972.9 986.8 1001.8 1027.8 1034.3 10194.4 11084.7 11085.3 11109.3 11133.2 380996.2 388400.0 475140.0 482264.0 486058.0 89709.0 91029.0 91636.0 93897.5 94684.5 979.1 1007.9 1024.3 1073.8 1074.9 16544.9 16799.9 17377.9 17481.5 17767.3 40391.8 40600.6 40887.6 41630.4 42774.0 57193.7 57763.4 58144.4 58449.1 58955.0 6816.3 7043.5 7512.3 7516.1 7834.8 10535.3 10727.9 11412.4 12949.9 12970.0 10880.6 11411.2 11679.7 11850.2 12146.5 10517.7 10557.5 11244.3 11347.7 11765.1 10598.9 10977.9 11332.8 11441.8 11951.5 8381.8 8448.3 8485.4 8583.6 8646.7 9124.3 10202.8 10625.7 10839.5 10886.3 23:49:13 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | [#3] mootools.html Cycles:180 Average:5398.99 Median:4938.78 stddev:3007.21 (60.9%) stddev-sans-first:3000.99 23:49:13 INFO - PROCESS | 15127 | Values: 1447.9 1481.8 1584.6 1688.8 1711.9 7376.3 7647.2 7705.1 8231.3 8259.4 7981.7 8228.3 8270.0 8386.5 8408.5 2298.3 2309.6 2330.2 2334.2 2338.8 2172.8 2203.8 2244.2 2245.0 2249.7 2283.1 2299.9 2305.9 2323.2 2326.3 2253.6 2254.2 2255.3 2266.9 2269.9 2192.6 2221.2 2223.3 2223.4 2240.7 8085.1 8266.9 8302.3 8382.2 8420.6 4687.7 4821.9 4833.2 4837.5 4872.8 3229.5 3259.3 3414.5 3414.6 3423.7 1163.1 1175.8 1185.8 1200.6 1214.6 11185.4 11230.9 11260.9 11329.3 11346.0 4212.7 4346.1 4429.3 4457.1 4543.0 9403.0 9405.0 9416.7 9443.5 9450.7 4984.4 4990.3 4993.4 5004.2 5033.8 4174.5 4176.5 4593.2 4621.9 4622.2 3713.8 3800.6 3814.9 3852.9 3894.5 1260.6 1273.9 1279.3 1279.9 1299.1 933.7 942.4 949.0 950.6 951.8 5397.9 5399.3 5523.4 5666.0 5777.5 443.2 446.8 447.3 450.7 453.8 3747.3 3765.2 3800.4 3889.8 3895.4 9439.4 9783.7 10054.1 10091.0 10096.4 9799.1 9839.9 9886.2 9898.8 9900.1 7452.4 7634.6 7678.7 7759.6 7794.9 5182.1 5219.3 5266.1 5405.6 5469.7 9230.9 9276.4 9336.8 9358.4 9386.3 8996.3 9473.9 9502.9 9513.0 9726.4 6594.7 6817.8 7076.0 7108.5 7195.8 8015.8 8049.7 8170.7 8174.0 8175.2 7187.8 7315.6 7388.8 7423.6 7447.5 7008.7 7019.4 7109.0 7253.7 7338.0 6546.6 6554.1 6596.8 6604.4 6613.7 4747.8 4839.6 4866.5 4949.4 4951.7 4707.0 4727.5 4813.5 4827.0 4928.1 23:49:13 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | [#4] prototype.html Cycles:180 Average:4573.88 Median:5062.84 stddev:1322.61 (26.1%) stddev-sans-first:1287.27 23:49:13 INFO - PROCESS | 15127 | Values: 323.5 325.8 331.4 337.3 339.6 5396.0 5447.5 5510.3 5519.5 5573.6 5433.5 5437.8 5457.8 5475.2 5484.6 4252.6 4266.0 4268.2 4268.6 4282.3 4033.6 4239.0 4297.5 4308.2 4314.7 4212.9 4227.2 4227.9 4229.5 4230.3 4153.9 4218.1 4221.1 4232.6 4234.2 3717.8 3731.9 3736.2 3738.0 3741.3 5191.5 5270.1 5297.0 5332.7 5337.2 4788.3 4801.8 4807.4 4808.8 4823.4 5408.0 5622.2 5622.9 5639.5 5692.9 4002.2 4040.5 4045.6 4046.5 4063.3 5855.0 5868.9 5885.4 5896.5 5903.9 4099.7 4110.8 4115.3 4118.9 4122.4 3978.0 4175.4 4190.0 4202.1 4203.2 4786.4 4803.8 4814.2 4822.1 4822.4 5697.2 5699.4 5722.5 5724.5 5763.0 1402.6 1437.7 1447.5 1451.2 1453.7 901.4 916.6 918.7 929.8 932.7 4657.4 4762.4 4764.7 4782.9 4793.0 5022.7 5040.9 5041.4 5047.8 5051.7 4534.6 4779.0 4786.0 4789.5 4816.1 2690.9 2696.7 2708.4 2710.7 2715.4 5186.1 5188.7 5251.8 5258.7 5258.8 4886.3 5135.4 5141.7 5165.6 5215.7 5182.8 5212.0 5224.5 5246.8 5295.5 5059.5 5090.2 5098.3 5106.9 5114.9 4749.7 4925.4 4980.9 5060.3 5065.4 5207.9 5236.6 5238.9 5245.8 5270.6 3774.9 3780.5 3968.9 4044.1 4104.6 5733.5 5766.4 5795.6 5803.4 5813.8 5666.5 5671.5 5682.3 5694.0 5709.8 5525.5 5626.4 5627.2 5640.0 5645.4 5559.8 5574.8 5581.2 5588.9 5594.6 5481.8 5652.3 5669.9 5684.0 5699.3 5580.2 5608.2 5612.0 5622.4 5628.4 23:49:13 INFO - PROCESS | 15127 | 23:49:13 INFO - PROCESS | 15127 | [#5] yui.html Cycles:180 Average:19662.98 Median:4668.29 stddev:28405.30 (608.5%) stddev-sans-first:28449.25 23:49:13 INFO - PROCESS | 15127 | Values: 686.3 763.0 764.4 797.6 838.9 16146.1 16928.7 16942.9 17037.7 17072.1 15057.2 15287.0 15306.8 15338.5 15390.0 780.0 786.2 789.7 798.3 800.6 803.1 804.1 805.0 805.1 805.3 850.8 852.4 853.1 853.5 853.7 844.9 845.4 845.5 846.6 847.1 626.5 627.1 627.1 627.9 628.2 14056.3 14064.0 14098.9 14102.1 14103.3 12768.2 12772.7 13178.5 13422.2 13773.8 11428.0 11471.1 11528.0 11745.2 12199.2 3797.3 3872.6 3892.9 4034.4 4044.4 78112.6 78379.6 78942.0 83324.0 83853.2 9788.2 9964.4 9969.0 10003.6 10308.9 20321.9 20351.7 20365.0 20405.3 20423.9 7595.1 8175.1 8452.6 8753.8 8835.5 4563.6 4592.4 4646.3 4690.2 4716.2 3289.8 3427.6 3442.5 3443.9 3461.3 638.3 675.6 683.5 685.5 698.3 617.3 627.4 655.3 659.2 682.4 9733.9 9899.5 10120.7 10133.6 10197.8 611.7 627.3 636.5 691.7 751.5 4693.8 4813.2 4900.1 4949.2 4963.4 78885.0 118665.4 122920.0 125874.0 126585.4 83061.0 83297.3 83418.6 107900.0 107958.0 50606.5 52210.2 53900.5 61343.7 77304.8 9258.9 9315.5 9500.0 9859.5 10220.2 34710.5 36646.6 47887.3 51476.5 52263.0 72333.6 72373.3 73357.0 73672.0 74306.6 11839.2 11941.2 12350.1 12395.6 12509.3 14208.0 14308.3 14529.4 14550.5 15098.9 13312.6 13520.2 13831.5 14262.7 14290.1 13110.6 13721.8 13979.7 14343.0 14451.8 13035.3 13519.3 13608.6 13847.4 13893.6 10170.9 10430.4 10454.2 10638.9 10691.4 9990.3 11215.5 11407.8 11730.7 11773.4 23:49:13 INFO - PROCESS | 15127 | -------- Summary: end -------- 23:49:13 INFO - PROCESS | 15127 | 23:49:14 INFO - TEST-INFO | 15127: exit 0 23:49:14 INFO - TEST-OK | dromaeo_css | took 1113941ms 23:49:14 INFO - TEST-START | kraken 23:49:14 INFO - operating with platform_type : linux_ 23:49:14 INFO - Initialising browser for kraken test... 23:49:14 INFO - TEST-INFO | started process 15489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTX0DeQ/profile http://localhost:44144/getInfo.html) 23:49:18 INFO - PROCESS | 15489 | __metrics Screen width/height:1600/1200 23:49:18 INFO - PROCESS | 15489 | colorDepth:24 23:49:18 INFO - PROCESS | 15489 | Browser inner width/height: 1024/697 23:49:18 INFO - PROCESS | 15489 | __metrics 23:49:19 ERROR - PROCESS | 15489 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 23:49:20 INFO - TEST-INFO | 15489: exit 0 23:49:20 INFO - Browser initialized. 23:49:20 INFO - Running cycle 1/1 for kraken test... 23:49:20 INFO - TEST-INFO | started process 15614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTX0DeQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:32 INFO - PROCESS | 15614 | RSS: Main: 185470976 23:49:32 INFO - PROCESS | 15614 | 23:49:35 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44144/tests/kraken/driver.html?testName=audio-beat-detection) 23:49:35 INFO - PROCESS | 15614 | RSS: Main: 199790592 23:49:35 INFO - PROCESS | 15614 | 23:49:38 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44144/tests/kraken/driver.html?testName=audio-dft) 23:49:39 INFO - PROCESS | 15614 | RSS: Main: 197271552 23:49:39 INFO - PROCESS | 15614 | 23:49:42 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44144/tests/kraken/driver.html?testName=audio-fft) 23:49:42 INFO - PROCESS | 15614 | RSS: Main: 193142784 23:49:42 INFO - PROCESS | 15614 | 23:49:44 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44144/tests/kraken/driver.html?testName=audio-oscillator) 23:49:45 INFO - PROCESS | 15614 | RSS: Main: 194007040 23:49:45 INFO - PROCESS | 15614 | 23:49:47 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:49:48 INFO - PROCESS | 15614 | RSS: Main: 194117632 23:49:48 INFO - PROCESS | 15614 | 23:49:51 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44144/tests/kraken/driver.html?testName=imaging-darkroom) 23:49:51 INFO - PROCESS | 15614 | RSS: Main: 194584576 23:49:51 INFO - PROCESS | 15614 | 23:49:55 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44144/tests/kraken/driver.html?testName=imaging-desaturate) 23:49:55 INFO - PROCESS | 15614 | RSS: Main: 195072000 23:49:55 INFO - PROCESS | 15614 | 23:49:58 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44144/tests/kraken/driver.html?testName=json-parse-financial) 23:49:59 INFO - PROCESS | 15614 | RSS: Main: 194637824 23:49:59 INFO - PROCESS | 15614 | 23:50:01 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:50:01 INFO - PROCESS | 15614 | RSS: Main: 194461696 23:50:01 INFO - PROCESS | 15614 | 23:50:03 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:50:04 INFO - PROCESS | 15614 | RSS: Main: 194322432 23:50:04 INFO - PROCESS | 15614 | 23:50:06 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:50:06 INFO - PROCESS | 15614 | RSS: Main: 194666496 23:50:06 INFO - PROCESS | 15614 | 23:50:09 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:50:10 INFO - PROCESS | 15614 | RSS: Main: 194785280 23:50:10 INFO - PROCESS | 15614 | 23:50:13 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:50:13 INFO - PROCESS | 15614 | RSS: Main: 194891776 23:50:13 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:44144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44144/tests/kraken/driver.html?testName=ai-astar) 23:50:15 INFO - PROCESS | 15614 | RSS: Main: 196116480 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | __start_tp_report 23:50:15 INFO - PROCESS | 15614 | _x_x_mozilla_page_load 23:50:15 INFO - PROCESS | 15614 | _x_x_mozilla_page_load_details 23:50:15 INFO - PROCESS | 15614 | |i|pagename|runs| 23:50:15 INFO - PROCESS | 15614 | |0;ai-astar;105;112;113;113;114;112;113;114;115;114 23:50:15 INFO - PROCESS | 15614 | |1;audio-beat-detection;155;126;127;165;127;129;125;124;157;125 23:50:15 INFO - PROCESS | 15614 | |2;audio-dft;164;165;162;164;171;162;161;161;163;163 23:50:15 INFO - PROCESS | 15614 | |3;audio-fft;76;77;76;107;76;76;77;78;101;77 23:50:15 INFO - PROCESS | 15614 | |4;audio-oscillator;82;83;108;83;81;82;103;82;82;108 23:50:15 INFO - PROCESS | 15614 | |5;imaging-gaussian-blur;118;119;117;118;118;117;118;118;117;119 23:50:15 INFO - PROCESS | 15614 | |6;imaging-darkroom;148;148;147;146;147;147;149;147;148;150 23:50:15 INFO - PROCESS | 15614 | |7;imaging-desaturate;96;99;96;96;96;96;98;97;97;96 23:50:15 INFO - PROCESS | 15614 | |8;json-parse-financial;55;52;53;54;59;58;54;55;55;60 23:50:15 INFO - PROCESS | 15614 | |9;json-stringify-tinderbox;63;62;62;61;62;64;63;62;62;63 23:50:15 INFO - PROCESS | 15614 | |10;stanford-crypto-aes;82;81;81;82;89;80;87;80;81;80 23:50:15 INFO - PROCESS | 15614 | |11;stanford-crypto-ccm;141;133;145;136;135;142;143;146;165;135 23:50:15 INFO - PROCESS | 15614 | |12;stanford-crypto-pbkdf2;171;168;170;166;168;168;169;178;171;169 23:50:15 INFO - PROCESS | 15614 | |13;stanford-crypto-sha256-iterative;76;69;68;70;66;69;66;67;66;70 23:50:15 INFO - PROCESS | 15614 | __end_tp_report 23:50:15 INFO - PROCESS | 15614 | __start_cc_report 23:50:15 INFO - PROCESS | 15614 | _x_x_mozilla_cycle_collect,761 23:50:15 INFO - PROCESS | 15614 | __end_cc_report 23:50:15 INFO - PROCESS | 15614 | __startTimestamp1475563815798__endTimestamp 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | ------- Summary: start ------- 23:50:15 INFO - PROCESS | 15614 | Number of tests: 14 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 23:50:15 INFO - PROCESS | 15614 | Values: 105.0 112.0 113.0 113.0 114.0 112.0 113.0 114.0 115.0 114.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:128.00 stddev:16.12 (12.6%) stddev-sans-first:15.57 23:50:15 INFO - PROCESS | 15614 | Values: 155.0 126.0 127.0 165.0 127.0 129.0 125.0 124.0 157.0 125.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.91 (1.8%) stddev-sans-first:3.09 23:50:15 INFO - PROCESS | 15614 | Values: 164.0 165.0 162.0 164.0 171.0 162.0 161.0 161.0 163.0 163.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.50 stddev:11.65 (15.2%) stddev-sans-first:12.14 23:50:15 INFO - PROCESS | 15614 | Values: 76.0 77.0 76.0 107.0 76.0 76.0 77.0 78.0 101.0 77.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.00 stddev:11.78 (14.4%) stddev-sans-first:12.18 23:50:15 INFO - PROCESS | 15614 | Values: 82.0 83.0 108.0 83.0 81.0 82.0 103.0 82.0 82.0 108.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 23:50:15 INFO - PROCESS | 15614 | Values: 118.0 119.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 23:50:15 INFO - PROCESS | 15614 | Values: 148.0 148.0 147.0 146.0 147.0 147.0 149.0 147.0 148.0 150.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:1.06 (1.1%) stddev-sans-first:1.09 23:50:15 INFO - PROCESS | 15614 | Values: 96.0 99.0 96.0 96.0 96.0 96.0 98.0 97.0 97.0 96.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:2.64 (4.8%) stddev-sans-first:2.79 23:50:15 INFO - PROCESS | 15614 | Values: 55.0 52.0 53.0 54.0 59.0 58.0 54.0 55.0 55.0 60.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 23:50:15 INFO - PROCESS | 15614 | Values: 63.0 62.0 62.0 61.0 62.0 64.0 63.0 62.0 62.0 63.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.50 stddev:3.13 (3.8%) stddev-sans-first:3.32 23:50:15 INFO - PROCESS | 15614 | Values: 82.0 81.0 81.0 82.0 89.0 80.0 87.0 80.0 81.0 80.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:142.50 stddev:9.26 (6.5%) stddev-sans-first:9.81 23:50:15 INFO - PROCESS | 15614 | Values: 141.0 133.0 145.0 136.0 135.0 142.0 143.0 146.0 165.0 135.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:169.50 stddev:3.26 (1.9%) stddev-sans-first:3.43 23:50:15 INFO - PROCESS | 15614 | Values: 171.0 168.0 170.0 166.0 168.0 168.0 169.0 178.0 171.0 169.0 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:3.02 (4.4%) stddev-sans-first:1.69 23:50:15 INFO - PROCESS | 15614 | Values: 76.0 69.0 68.0 70.0 66.0 69.0 66.0 67.0 66.0 70.0 23:50:15 INFO - PROCESS | 15614 | -------- Summary: end -------- 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | 23:50:15 INFO - PROCESS | 15614 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:50:15 INFO - PROCESS | 15614 | 23:50:16 INFO - TEST-INFO | 15614: exit 0 23:50:16 INFO - TEST-OK | kraken | took 62172ms 23:50:16 INFO - SUITE-END | took 1176s 23:50:16 INFO - Completed test suite (00:19:36) 23:50:16 INFO - javascript benchmark 23:50:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7056.478530360498, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.438073956318, 3071.2168397058745, 3085.72228499435, 3091.8608662610195, 3096.1949893027822, 5180.559652429539, 5315.14957606783, 5332.893342133159, 5387.622866399349, 5437.265969094171, 5233.0, 5254.343207099113, 5294.338207724035, 5318.414974352818, 5344.706041167734, 4745.050989802036, 4832.323474713543, 4844.636652251095, 4864.805407783702, 4881.707097574139, 4897.216445368742, 4915.754212289389, 4920.917398172396, 4951.752412379385, 4983.028309479653, 4719.221328480797, 4763.214069678499, 4770.165221086296, 4830.782614782325, 4834.250691142878, 4781.760911954389, 4794.208955522335, 4800.591949684281, 4843.564079232886, 4862.440819305754, 4723.149833030053, 4730.739809310487, 4759.309900064506, 4773.355596994396, 4805.399325084364, 5227.764750586195, 5241.764120614582, 5281.603879709037, 5324.520793128599, 5347.171188465794, 5565.3599836018975, 5611.7474713637985, 5615.354234263071, 5663.320401551799, 5717.9714101429645, 5668.178114173463, 5675.290588676416, 5677.148427735831, 5682.659040457585, 5692.1461780733225, 5192.714400707921, 5302.09864323066, 5305.681659100466, 5352.999999999961, 5380.273663055437, 5655.688937108499, 5721.885562288731, 5740.167675687002, 5746.310442746813, 5824.650520968756, 5524.58565607573, 5533.3083364579425, 5538.75075621598, 5542.667439953616, 5569.470900264469, 5387.218853266255, 5567.944320556742, 5571.498565129158, 5621.662700237999, 5647.6893770843, 5397.514223719884, 5519.448055194448, 5542.11326187808, 5543.556515478752, 5636.774529018793, 5505.449455054462, 5520.337559492887, 5520.66875987442, 5533.280673512418, 5569.081101618269, 4322.7190232634775, 4345.391645169679, 4352.086061926968, 4394.780260986938, 4396.296592545242, 3851.0372406898277, 3880.3403421418425, 3883.436901649245, 3911.100446897173, 3924.7448915820382, 5348.465153484698, 5384.838454846361, 5387.703676297763, 5397.136458166675, 5444.373897001817, 5628.690422026828, 5656.490915817596, 5673.8297851064535, 5699.2590963174525, 5699.544036477072, 5271.894562108736, 5275.736213189325, 5303.920441193385, 5366.034113859465, 5407.270018547446, 4871.8294859679745, 4874.805007799649, 4886.706797592155, 4918.532739389752, 4923.359963204761, 5716.142578613241, 5748.396418376094, 5754.395788442153, 5758.174498239528, 5824.388439213822, 5607.691576963306, 5613.46672066153, 5617.634853734494, 5634.464725851038, 5668.914966275427, 5806.274215723035, 5863.20846685692, 5874.03078492044, 5929.792457263975, 5943.494802941798, 5551.417101204477, 5578.079616863334, 5584.966781145501, 5595.692236927008, 5599.552035837041, 5488.4237155098135, 5532.944670553243, 5685.800996965087, 5686.829395118153, 5702.116171993348, 5411.729413529387, 5455.427180146186, 5457.126859702428, 5462.590305727166, 5464.316960379952, 5444.754986025559, 5449.073657478159, 5449.155380915964, 5450.972745136408, 5451.4276001019325, 5383.81156659515, 5386.784528618811, 5400.459954004568, 5437.619366644455, 5459.399466058651, 5627.296587926509, 5633.718314084197, 5634.774609015593, 5642.0, 5644.745986430703, 5497.945020549743, 5511.862203444946, 5512.448755124456, 5514.255575497256, 5517.0], "value": 5207.182996911904, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6871536297353, 566.0603398358725, 572.9255196824412, 588.7174156404927, 591.3377017740132, 45483.0, 48088.759556202254, 48320.0, 48472.75763621177, 48541.51458485414, 44734.32898506517, 45388.3191752124, 45444.318335225, 45471.0, 45607.31589026159, 8975.596098175582, 9130.406523575946, 9133.543322833864, 9135.68025119121, 9157.0, 8948.64205431782, 9001.909980900173, 9041.547922603877, 9052.954735226314, 9054.728358149267, 9063.048379920112, 9093.454392736458, 9100.681476148337, 9122.361434699573, 9130.132637399436, 8984.146506081945, 8996.145366190201, 8999.280057595377, 9013.414128081686, 9044.502552359618, 8875.334349923716, 8905.465672059698, 8936.597853096626, 9000.189982901571, 9014.459132452008, 42561.36157957633, 42921.57078429207, 42943.35584966228, 43124.35313470301, 43317.0, 3454.5336379588684, 3456.792592444436, 3533.8586456541707, 3539.132912436444, 3619.7285203609836, 31688.524672129937, 31742.523862141854, 32261.677383226335, 33501.83249083763, 33630.32739345224, 4271.359296105609, 4343.370211319372, 4396.714213576107, 4466.196084704752, 4477.820887164509, 345080.0, 345589.0, 345687.0, 345984.0, 346718.9999999975, 59909.0, 60232.39767602268, 60238.0, 60486.69756651277, 60506.39493605096, 56666.0, 56869.0, 57039.14441283384, 57042.42957570454, 57198.42801572014, 15993.200339982954, 16035.599110022109, 16040.278187481592, 16099.75850362222, 16198.75701864473, 10658.253922225525, 10719.19606029551, 10884.945575272073, 10900.781984360268, 10975.341479511255, 16750.0, 17030.74453883193, 17222.224999875034, 17229.56926076858, 17473.0, 5775.451332123442, 5804.4195580442465, 5966.164736936832, 5989.371116032841, 5993.520518358521, 947.8293907096651, 981.0777868803302, 1052.652624633869, 1107.5680484611007, 1133.3086817041599, 30969.8451507741, 31249.8437507811, 31270.374592508022, 31740.365192696478, 31769.8411507941, 1010.4947526236881, 1076.4187338837096, 1093.2893619147617, 1126.8366086917351, 1167.2762887009937, 16981.915090424467, 17009.744853827204, 17056.914715426345, 17071.402500912656, 17134.914325428294, 457595.0, 457620.0, 458282.0, 459264.0, 460880.0, 56300.71849640726, 57339.13991290134, 57587.0, 57618.711906441036, 57694.76883698588, 1318.373772458094, 1342.8992825537928, 1356.2608378433777, 1362.2507620808515, 1375.6629625741557, 29960.400791984473, 30834.69165308318, 31590.81723788659, 31897.202569935936, 31921.0, 50911.74544127256, 51286.743566281926, 51394.74302628463, 51485.227721583455, 51516.0, 404153.979230102, 404703.0, 405924.0, 407913.0, 407913.0, 40236.1952760949, 40541.0, 40651.0, 40881.0, 41036.58963410328, 46879.53120468752, 47229.2915606273, 47654.28518572155, 48433.27350089681, 49234.75382623064, 39703.60296396999, 40430.59569404386, 40822.59177408307, 42187.78906105573, 42229.57770422257, 40528.3920741195, 40563.18873622452, 41151.38272925968, 41267.38098928458, 41634.79182604067, 40013.0, 40823.59176408317, 40933.38599921063, 40964.0, 43455.13089738251, 31071.84464077665, 35607.28785424329, 36871.26257474889, 37502.43746343862, 37638.059048524, 27131.1860644181, 27404.177874663794, 27627.171184864485, 27757.30606734767, 27928.720712792612], "value": 19965.518741149288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.9518857737072, 402.31606269342115, 402.3341370032597, 402.86101295053203, 423.34170365082286, 18221.544461388472, 19707.11317990692, 19753.20987160512, 19825.40523784287, 20502.282420115298, 18647.25410983559, 19089.904550477262, 19206.135723892425, 19224.327148549804, 19523.804761952375, 5604.075327570946, 5646.378898321202, 5832.883342333151, 5863.179154918314, 5874.676892770896, 5745.712714364286, 5769.451902069297, 5780.855478613026, 5822.097574875901, 5845.415458454142, 5519.503244707976, 5769.336526299488, 5772.220750198732, 5780.248567686216, 5782.913256301159, 5607.775688972436, 5766.279215098113, 5773.826785196451, 5776.480116789488, 5777.075667893117, 5060.74696265189, 5067.189249720027, 5125.077486052509, 5133.486651334837, 5139.665921715114, 22939.77060229393, 23330.300090997298, 23378.0, 23418.648720269208, 23554.175603853953, 2379.5121999990133, 2428.562858685436, 2430.5989511730545, 2555.1567982565894, 2564.8204625676212, 13868.583942481742, 14139.363728632236, 14304.856951430456, 14525.983181177322, 15307.0, 1895.5355937795327, 1975.101328895349, 2014.8085931836451, 2059.073416962358, 2063.0509965415927, 75681.24318756851, 78072.0, 79223.6038819808, 81025.59487202526, 81061.59469202616, 9271.258299336037, 9799.11807937289, 9805.558749856273, 10346.32748871321, 10453.163746900229, 11944.522219111312, 13152.934235328763, 13254.40355184019, 13339.466421343232, 13392.464301428028, 5679.460451257124, 5744.741486633112, 6392.616443013434, 7455.701771929171, 7719.575423351769, 7376.3160393149665, 7414.6292685365515, 7559.395248380117, 7601.429892757955, 7660.731874384482, 4072.837086516506, 4193.832246710159, 4196.475440569929, 4206.453161089039, 4271.9359209611885, 1891.564940063793, 1925.6218570065957, 1967.9508012299807, 2012.1146695453954, 2064.977835971204, 836.2139588786521, 919.5218486387041, 935.1770442010986, 938.4791440750449, 1050.6217761605815, 18592.81407185911, 19582.0, 19750.70373944392, 19891.233847228574, 19922.103505342293, 972.8735264415723, 986.7631768375538, 1001.7746007148334, 1027.845823126537, 1034.2966782587762, 10194.388336699822, 11084.667459976214, 11085.27945683528, 11109.333439993627, 11133.165012624086, 380996.1854386781, 388400.0, 475140.0, 482264.0, 486058.0, 89709.0, 91029.0, 91636.0, 93897.530512347, 94684.52657736804, 979.0747743382435, 1007.8790545134631, 1024.2625309777097, 1073.8120828855076, 1074.8817630060687, 16544.917275413547, 16799.91600041992, 17377.91311043437, 17481.47555573335, 17767.289308427517, 40391.798041009606, 40600.59399405968, 40887.591124089566, 41630.37554436747, 42774.0, 57193.714031429576, 57763.422365777486, 58144.418555815595, 58449.12326315194, 58955.0, 6816.318368163343, 7043.542169758949, 7512.32389084985, 7516.098068231847, 7834.843303133792, 10535.262531623019, 10727.892721072689, 11412.372319522174, 12949.935250323688, 12970.0, 10880.564777408816, 11411.201215914807, 11679.708007299545, 11850.170488065753, 12146.453409596767, 10517.737056573647, 10557.472126393803, 11244.26912250701, 11347.730453909086, 11765.11761617865, 10598.89401105979, 10977.890221098007, 11332.773344533229, 11441.771164576496, 11951.521939122338, 8381.790455238668, 8448.324134069137, 8485.448445851247, 8583.613737381707, 8646.654133834576, 9124.31567632417, 10202.795944081225, 10625.734356641145, 10839.512221949873, 10886.29239099456], "value": 9003.787075272528, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.9348429320682, 1481.8369979302274, 1584.564244832671, 1688.77324680115, 1711.9058451785163, 7376.262373762621, 7647.158812530617, 7705.113911900133, 8231.259186673205, 8259.380546459017, 7981.720639777609, 8228.341732661387, 8269.958650206741, 8386.496810191393, 8408.495490270589, 2298.276043046443, 2309.642005489152, 2330.1960823515947, 2334.171369163948, 2338.766123387656, 2172.7827217278223, 2203.8236941044756, 2244.1920908472935, 2245.045855511409, 2249.741279752833, 2283.1438210671, 2299.9310020699404, 2305.8616483010987, 2323.186884590397, 2326.255598208574, 2253.5718213539376, 2254.222293308814, 2255.3008567344177, 2266.9206577769783, 2269.931902042933, 2192.6162921488835, 2221.1892659179284, 2223.321886824518, 2223.377454312795, 2240.7423146338215, 8085.070216925012, 8266.875996860052, 8302.294304984083, 8382.203690649378, 8420.578971051484, 4687.742174180418, 4821.93917338185, 4833.178359678828, 4837.4920633333695, 4872.805087796484, 3229.450993331116, 3259.3318369734147, 3414.453687410027, 3414.5561077059824, 3423.726101911866, 1163.0927876256533, 1175.7530918507123, 1185.8161984892356, 1200.6218041316956, 1214.6113243762, 11185.384803835786, 11230.94384528072, 11260.887391126065, 11329.320240785579, 11346.0, 4212.662986961036, 4346.065595896897, 4429.313456414261, 4457.108578284357, 4543.0, 9402.95298523503, 9405.0, 9416.71749847492, 9443.527823608929, 9450.716478505656, 4984.4267909190185, 4990.2764099205415, 4993.375828021497, 5004.174311238605, 5033.823816166417, 4174.533249423088, 4176.540580536139, 4593.150267200579, 4621.861344159681, 4622.237330840374, 3713.814309284525, 3800.600936901641, 3814.885553433346, 3852.9229415412096, 3894.5131858517684, 1260.5588044184644, 1273.866244044362, 1279.251637791902, 1279.8720127987126, 1299.1166007115064, 933.6545478173119, 942.4062840410497, 948.990510094904, 950.6387572722322, 951.757301888028, 5397.946020539823, 5399.325084364455, 5523.4200408956485, 5665.9716701417055, 5777.508911742465, 443.1933880337754, 446.75205261079765, 447.34910704924255, 450.6507456721067, 453.77991674038066, 3747.3442147624055, 3765.1904840459433, 3800.4299355096405, 3889.766614003169, 3895.3962135868987, 9439.386439881524, 9783.706488805346, 10054.145397641136, 10091.0, 10096.394216347042, 9799.118079372749, 9839.901600983898, 9886.209103271722, 9898.752531186778, 9900.108990190773, 7452.366548843409, 7634.6182690865235, 7678.731244406419, 7759.612019399007, 7794.883076753853, 5182.144946083854, 5219.321488206509, 5266.078436273713, 5405.621606487508, 5469.671819690831, 9230.907690923004, 9276.397034192756, 9336.766580835261, 9358.4384936904, 9386.342955993015, 8996.325275604226, 9473.857892131762, 9502.85745713801, 9512.95243523778, 9726.36778609388, 6594.670266486753, 6817.795466136024, 7076.0, 7108.466864985044, 7195.784126476214, 8015.799605009922, 8049.678012879419, 8170.714025009096, 8173.959130204311, 8175.182481751777, 7187.7843664690145, 7315.6342182889575, 7388.7808511594985, 7423.5917024562, 7447.515911465737, 7008.719651214098, 7019.403350715246, 7108.964455177691, 7253.673584688807, 7338.046054013158, 6546.607203567801, 6554.14796076507, 6596.835079122869, 6604.3725846044545, 6613.66931653425, 4747.786349614206, 4839.612830973443, 4866.464688884149, 4949.430815456269, 4951.678140920829, 4706.952930470651, 4727.456342520654, 4813.4945830687275, 4826.975865120652, 4928.137575924271], "value": 4312.432333437752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.5147279081378, 325.8110296028304, 331.36212790378517, 337.28159021284654, 339.5907930943214, 5396.0, 5447.509724124828, 5510.311211098613, 5519.482142410839, 5573.600103936596, 5433.532946104549, 5437.809676661318, 5457.844151560132, 5475.151351540508, 5484.61607687462, 4252.639784919361, 4266.0, 4268.167707297078, 4268.551802060785, 4282.29342158545, 4033.5966403359575, 4239.0, 4297.505786834523, 4308.2029824482415, 4314.654827613799, 4212.894677633053, 4227.154569086195, 4227.915441691164, 4229.450171477703, 4230.280852255124, 4153.902279348939, 4218.135282267143, 4221.134667393208, 4232.555581663943, 4234.216669916075, 3717.8141092945243, 3731.9253614927547, 3736.23407201523, 3738.0, 3741.345264578688, 5191.454897235773, 5270.130428479335, 5297.020051290524, 5332.733363331818, 5337.199420086979, 4788.257820037899, 4801.783919723586, 4807.375041244651, 4808.807647694123, 4823.397075365579, 5407.999520088757, 5622.156676498558, 5622.859428514279, 5639.520640745542, 5692.9146062809095, 4002.239574480839, 4040.5353384360883, 4045.615666511677, 4046.4941882264716, 4063.329550624173, 5854.97072514639, 5868.889488571064, 5885.411458854123, 5896.498797602209, 5903.940960590382, 4099.672026237894, 4110.77390743506, 4115.32097203964, 4118.897027574335, 4122.42286079949, 3978.0, 4175.394567787654, 4189.979050104791, 4202.117555313357, 4203.222403855297, 4786.44955830084, 4803.759812009385, 4814.15752243363, 4822.132016237041, 4822.397200349957, 5697.230873832063, 5699.373068962411, 5722.456366645162, 5724.484796368263, 5762.971185144132, 1402.6212922510865, 1437.6549628089183, 1447.5440236325524, 1451.2163431746737, 1453.716525277582, 901.4411065139656, 916.6058594804298, 918.6830543462495, 929.7768535551419, 932.7341707613298, 4657.439757681214, 4762.3570817939135, 4764.690295130806, 4782.928256076161, 4792.976035119872, 5022.744313921519, 5040.874657712242, 5041.42023667283, 5047.848564543069, 5051.696898186121, 4534.614557762561, 4778.976105119452, 4786.0, 4789.473157952622, 4816.0622020567425, 2690.9327266818486, 2696.7303269672875, 2708.404151086758, 2710.7289271072736, 2715.4297597504747, 5186.066508028591, 5188.688678679291, 5251.8161864335325, 5258.7370631468275, 5258.765858996766, 4886.3403440535785, 5135.35808023997, 5141.717205553656, 5165.560927321219, 5215.6609820361555, 5182.792688292501, 5211.973940130275, 5224.499585277873, 5246.790128394974, 5295.4969277918535, 5059.46875578059, 5090.2364645303505, 5098.311727916684, 5106.897862042664, 5114.9232761507865, 4749.715017098985, 4925.359703238556, 4980.900381992267, 5060.291559181791, 5065.39215294167, 5207.869803254949, 5236.633435659467, 5238.869028274171, 5245.8229834618205, 5270.578353731616, 3774.943375849419, 3780.527434070741, 3968.9206215876097, 4044.130511939947, 4104.589541045872, 5733.455321744427, 5766.365699773106, 5795.565332600157, 5803.448672376117, 5813.82558523245, 5666.546676265806, 5671.512020107687, 5682.289713785777, 5693.971530142323, 5709.800156994485, 5525.530329922001, 5626.409227031267, 5627.212190293444, 5640.0, 5645.40723224072, 5559.777608895761, 5574.804881829116, 5581.246531718329, 5588.916166257428, 5594.636348637326, 5481.808136715196, 5652.3217213934595, 5669.914951275817, 5684.0, 5699.287589051369, 5580.190872323572, 5608.186812912187, 5611.971940140274, 5622.409646987171, 5628.437156284503], "value": 4153.3409886837335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.296546040309, 762.9852296445728, 764.373213964549, 797.6171437709895, 838.9370797190209, 16146.111963841984, 16928.661426771487, 16942.915285423587, 17037.744433833486, 17072.06103664298, 15057.17185554794, 15287.0, 15306.770398444032, 15338.539843804676, 15390.0, 779.9961000195005, 786.2294950948075, 789.656499422753, 798.2895223251311, 800.6077022259109, 803.1366281247653, 804.0913767442811, 805.0259186384482, 805.0540614777642, 805.2873207211601, 850.7617866997251, 852.4160949749441, 853.0786750309651, 853.5476197615274, 853.7182729699215, 844.9028361738386, 845.4124383553464, 845.4927043773748, 846.6105591427951, 847.0851480401183, 626.5488848029412, 627.087587560099, 627.1408170806025, 627.9058141278799, 628.1990462160736, 14056.297185140702, 14064.0, 14098.929505352407, 14102.083364581373, 14103.294835258299, 12768.233905965672, 12772.744545109046, 13178.53875114376, 13422.194668319835, 13773.793393099111, 11428.0, 11471.082313414907, 11528.020118289955, 11745.177837551375, 12199.20705154171, 3797.3354662933875, 3872.5546562145432, 3892.8637497687446, 4034.394840773878, 4044.4337792709043, 78112.60943695302, 78379.60810195969, 78942.0, 83323.99999999939, 83853.16146838515, 9788.168005719452, 9964.352317099365, 9969.003099689973, 10003.599856005678, 10308.896911030944, 20321.89839050795, 20351.69472457914, 20365.0, 20405.285814996405, 20423.897880510503, 7595.126560445509, 8175.100738918714, 8452.61963211657, 8753.781155471164, 8835.514046727363, 4563.634909207255, 4592.357070010201, 4646.3495110684535, 4690.226112691436, 4716.198246298138, 3289.8190599517256, 3427.622961474236, 3442.535257740223, 3443.9311213776086, 3461.3423449545007, 638.2787450181265, 675.6250281093942, 683.5181197255922, 685.540687739216, 698.27728301208, 617.299365220478, 627.4039662320722, 655.2693746472744, 659.222117900872, 682.3619915379037, 9733.902660973441, 9899.455529945779, 10120.696379108638, 10133.64532241368, 10197.847032294521, 611.7002668692309, 627.2817623820699, 636.5257882877286, 691.7025678958096, 751.4739682222466, 4693.78877950493, 4813.15769740294, 4900.142475066849, 4949.1586430306215, 4963.379577552806, 78885.0, 118665.36799780122, 122920.0, 125874.0, 126585.3670731659, 83061.0, 83297.3340533186, 83418.58290708507, 107900.0, 107958.0, 50606.49393506091, 52210.21684674733, 53900.46099539033, 61343.6932815342, 77304.84042739363, 9258.907410925805, 9315.487648179414, 9500.0, 9859.507024648596, 10220.182385409, 34710.47934281038, 36646.633533664324, 47887.28169077397, 51476.48523514717, 52263.0, 72333.638331808, 72373.27626723665, 73357.0, 73672.0, 74306.62846685732, 11839.1712580122, 11941.16411851162, 12350.135490515577, 12395.588213345762, 12509.311987840756, 14208.0, 14308.284585770878, 14529.418823246951, 14550.490732824725, 15098.924505377403, 13312.600621981355, 13520.18878867271, 13831.515896943558, 14262.71474570482, 14290.071145375518, 13110.606681799562, 13721.794173087212, 13979.650508737363, 14343.0, 14451.78322325187, 13035.348232588522, 13519.256440895846, 13608.591742247749, 13847.376868040761, 13893.58319250424, 10170.898291016994, 10430.37417754937, 10454.163666906781, 10638.89361106379, 10691.358518488916, 9990.300678952404, 11215.527667083024, 11407.828882566602, 11730.706732331419, 11773.411329433322], "value": 7362.939812542094, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 113.0, 114.0, 112.0, 113.0, 114.0, 115.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 127.0, 165.0, 127.0, 129.0, 125.0, 124.0, 157.0, 125.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 164.0, 171.0, 162.0, 161.0, 161.0, 163.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 107.0, 76.0, 76.0, 77.0, 78.0, 101.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 108.0, 83.0, 81.0, 82.0, 103.0, 82.0, 82.0, 108.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 146.0, 147.0, 147.0, 149.0, 147.0, 148.0, 150.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 96.0, 96.0, 96.0, 96.0, 98.0, 97.0, 97.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 54.0, 59.0, 58.0, 54.0, 55.0, 55.0, 60.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 62.0, 64.0, 63.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 82.0, 89.0, 80.0, 87.0, 80.0, 81.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 133.0, 145.0, 136.0, 135.0, 142.0, 143.0, 146.0, 165.0, 135.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 170.0, 166.0, 168.0, 168.0, 169.0, 178.0, 171.0, 169.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 68.0, 70.0, 66.0, 69.0, 66.0, 67.0, 66.0, 70.0], "value": 68.7, "unit": "score"}]}]} 23:50:17 INFO - Return code: 0 23:50:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:50:17 ERROR - # TBPL SUCCESS # 23:50:17 INFO - Running post-action listener: _resource_record_post_action 23:50:17 INFO - [mozharness: 2016-10-04 06:50:17.089060Z] Finished run-tests step (success) 23:50:17 INFO - Running post-run listener: _resource_record_post_run 23:50:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393494528; Read time: 180; Write time: 277896 23:50:17 INFO - TinderboxPrint: CPU usage
13.5% 23:50:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 23:50:17 INFO - TinderboxPrint: I/O write bytes / time
393,494,528 / 277,896 23:50:17 INFO - TinderboxPrint: CPU idle
8,233.3 (86.5%) 23:50:17 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 23:50:17 INFO - TinderboxPrint: Swap in / out
0 / 0 23:50:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103661568; Read time: 0; Write time: 70176 23:50:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289832960; Read time: 164; Write time: 207720 23:50:17 INFO - Running post-run listener: _upload_blobber_files 23:50:17 INFO - Blob upload gear active. 23:50:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:50:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:50:18 INFO - (blobuploader) - INFO - Open directory for files ... 23:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:18 INFO - (blobuploader) - INFO - Done attempting. 23:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:50:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:22 INFO - (blobuploader) - INFO - Done attempting. 23:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:50:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:22 INFO - (blobuploader) - INFO - Done attempting. 23:50:22 INFO - (blobuploader) - INFO - Iteration through files over. 23:50:22 INFO - Return code: 0 23:50:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:50:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:50:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f9f143198008f11166cb14a367ff9ba95e174f2b628a3bc4244247073ed34f4e26550951b4df791f18aa5490a2dae3cc048ca4490d16fde2ceff69324e6bcf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/23904bab2ee23fc41780ad151190c79e9fa2e129d15d585f4b557431ec6b734b8d5ccf18d7fe712523249c1f4900741a323d2cc5ca3a8c68bb1f821bb541197c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcd2bf0d6854898a645a220f3bc0fae18aa8caf4830fb3da08aa1c20fdf08c412dd1b723e9d888143c6f9faf2558ffab2145ee67d7abfb7bc9bdbc8f71d64af1"} 23:50:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:50:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:50:22 INFO - Contents: 23:50:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f9f143198008f11166cb14a367ff9ba95e174f2b628a3bc4244247073ed34f4e26550951b4df791f18aa5490a2dae3cc048ca4490d16fde2ceff69324e6bcf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/23904bab2ee23fc41780ad151190c79e9fa2e129d15d585f4b557431ec6b734b8d5ccf18d7fe712523249c1f4900741a323d2cc5ca3a8c68bb1f821bb541197c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcd2bf0d6854898a645a220f3bc0fae18aa8caf4830fb3da08aa1c20fdf08c412dd1b723e9d888143c6f9faf2558ffab2145ee67d7abfb7bc9bdbc8f71d64af1"} 23:50:22 INFO - Running post-run listener: copy_logs_to_upload_dir 23:50:22 INFO - Copying logs to upload dir... 23:50:22 INFO - mkdir: /builds/slave/test/build/upload/logs 23:50:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.061984 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-03 23:50:22.379072) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 23:50:22.383140) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f9f143198008f11166cb14a367ff9ba95e174f2b628a3bc4244247073ed34f4e26550951b4df791f18aa5490a2dae3cc048ca4490d16fde2ceff69324e6bcf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/23904bab2ee23fc41780ad151190c79e9fa2e129d15d585f4b557431ec6b734b8d5ccf18d7fe712523249c1f4900741a323d2cc5ca3a8c68bb1f821bb541197c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcd2bf0d6854898a645a220f3bc0fae18aa8caf4830fb3da08aa1c20fdf08c412dd1b723e9d888143c6f9faf2558ffab2145ee67d7abfb7bc9bdbc8f71d64af1"} build_url:https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f9f143198008f11166cb14a367ff9ba95e174f2b628a3bc4244247073ed34f4e26550951b4df791f18aa5490a2dae3cc048ca4490d16fde2ceff69324e6bcf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/23904bab2ee23fc41780ad151190c79e9fa2e129d15d585f4b557431ec6b734b8d5ccf18d7fe712523249c1f4900741a323d2cc5ca3a8c68bb1f821bb541197c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcd2bf0d6854898a645a220f3bc0fae18aa8caf4830fb3da08aa1c20fdf08c412dd1b723e9d888143c6f9faf2558ffab2145ee67d7abfb7bc9bdbc8f71d64af1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 23:50:22.408161) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:50:22.408532) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1475562582.413190-1854932287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:50:22.492549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 23:50:22.493066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 23:50:22.493380) ========= ========= Total master_lag: 0.14 =========