builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1462532190.71 results: success (0) buildid: 20160506013026 builduid: 2528682eb08448be8f78cd434f6df8c5 revision: 5896e929871bb58cf454238bcf82bff6c906e834 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.713580) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.714047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.714341) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.758614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.758896) ========= 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=00204705a9daa57ed339a427000001b9-1462532075.292321-620422555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 03:56:30-- 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% 86.0M=0s 2016-05-06 03:56:30 (86.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.893485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.893765) ========= 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=00204705a9daa57ed339a427000001b9-1462532075.292321-620422555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018470 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.943113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:30.943468) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5896e929871bb58cf454238bcf82bff6c906e834 --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 5896e929871bb58cf454238bcf82bff6c906e834 --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=00204705a9daa57ed339a427000001b9-1462532075.292321-620422555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 03:56:30,961 truncating revision to first 12 chars 2016-05-06 03:56:30,961 Setting DEBUG logging. 2016-05-06 03:56:30,961 attempt 1/10 2016-05-06 03:56:30,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5896e929871b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 03:56:31,306 unpacking tar archive at: mozilla-inbound-5896e929871b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:31.663733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:31.664096) ========= script_repo_revision: 5896e929871bb58cf454238bcf82bff6c906e834 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:31.664584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:31.664861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:56:31.674890) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-06 03:56:31.675203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=00204705a9daa57ed339a427000001b9-1462532075.292321-620422555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:56:31 INFO - MultiFileLogger online at 20160506 03:56:31 in /builds/slave/test 03:56:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:56:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:56:31 INFO - {'append_to_log': False, 03:56:31 INFO - 'base_work_dir': '/builds/slave/test', 03:56:31 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:56:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:56:31 INFO - 'branch': 'Mozilla-Inbound', 03:56:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:56:31 INFO - 'config_files': ('talos/linux_config.py',), 03:56:31 INFO - 'default_actions': ('clobber', 03:56:31 INFO - 'read-buildbot-config', 03:56:31 INFO - 'download-and-extract', 03:56:31 INFO - 'populate-webroot', 03:56:31 INFO - 'create-virtualenv', 03:56:31 INFO - 'install', 03:56:31 INFO - 'run-tests'), 03:56:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:56:31 INFO - 'download_minidump_stackwalk': True, 03:56:31 INFO - 'download_symbols': 'ondemand', 03:56:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:56:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:56:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:56:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:56:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:56:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:56:31 INFO - 'installer_path': 'installer.exe', 03:56:31 INFO - 'log_level': 'info', 03:56:31 INFO - 'log_name': 'talos', 03:56:31 INFO - 'log_to_console': True, 03:56:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:56:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:56:31 INFO - 'opt_config_files': (), 03:56:31 INFO - 'pip_index': False, 03:56:31 INFO - 'sps_profile': False, 03:56:31 INFO - 'sps_profile_interval': 0, 03:56:31 INFO - 'suite': 'dromaeojs', 03:56:31 INFO - 'system_bits': '32', 03:56:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:56:31 INFO - 'title': 'talos-linux64-ix-016', 03:56:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:56:31 INFO - 'use_talos_json': True, 03:56:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:56:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:56:31 INFO - 'work_dir': 'build'} 03:56:31 INFO - ##### 03:56:31 INFO - ##### Running clobber step. 03:56:31 INFO - ##### 03:56:31 INFO - Running pre-action listener: _resource_record_pre_action 03:56:31 INFO - Running main action method: clobber 03:56:31 INFO - rmtree: /builds/slave/test/build 03:56:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:56:32 INFO - Running post-action listener: _resource_record_post_action 03:56:32 INFO - ##### 03:56:32 INFO - ##### Finished clobber step (success) 03:56:32 INFO - ##### 03:56:32 INFO - ##### 03:56:32 INFO - ##### Running read-buildbot-config step. 03:56:32 INFO - ##### 03:56:32 INFO - Running pre-action listener: _resource_record_pre_action 03:56:32 INFO - Running main action method: read_buildbot_config 03:56:32 INFO - Using buildbot properties: 03:56:32 INFO - { 03:56:32 INFO - "project": "", 03:56:32 INFO - "product": "firefox", 03:56:32 INFO - "script_repo_revision": "production", 03:56:32 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:56:32 INFO - "repository": "", 03:56:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:56:32 INFO - "buildid": "20160506013026", 03:56:32 INFO - "pgo_build": "True", 03:56:32 INFO - "basedir": "/builds/slave/test", 03:56:32 INFO - "buildnumber": 943, 03:56:32 INFO - "slavename": "talos-linux64-ix-016", 03:56:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:56:32 INFO - "platform": "ubuntu64_hw", 03:56:32 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:56:32 INFO - "branch": "mozilla-inbound", 03:56:32 INFO - "repo_path": "integration/mozilla-inbound", 03:56:32 INFO - "revision": "5896e929871bb58cf454238bcf82bff6c906e834", 03:56:32 INFO - "stage_platform": "linux64-pgo", 03:56:32 INFO - "builduid": "2528682eb08448be8f78cd434f6df8c5", 03:56:32 INFO - "slavebuilddir": "test" 03:56:32 INFO - } 03:56:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:56:32 INFO - Running post-action listener: _resource_record_post_action 03:56:32 INFO - ##### 03:56:32 INFO - ##### Finished read-buildbot-config step (success) 03:56:32 INFO - ##### 03:56:32 INFO - ##### 03:56:32 INFO - ##### Running download-and-extract step. 03:56:32 INFO - ##### 03:56:32 INFO - Running pre-action listener: _resource_record_pre_action 03:56:32 INFO - Running main action method: download_and_extract 03:56:32 INFO - mkdir: /builds/slave/test/build/tests 03:56:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:32 INFO - https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:56:33 INFO - Downloaded 1361 bytes. 03:56:33 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:56:33 INFO - Using the following test package requirements: 03:56:33 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:56:33 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:56:33 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:56:33 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:33 INFO - u'jsshell-linux-x86_64.zip'], 03:56:33 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:56:33 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:56:33 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:56:33 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:56:33 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:56:33 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:56:33 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:56:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:33 INFO - https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:56:34 INFO - Downloaded 23883193 bytes. 03:56:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:56:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:56:35 INFO - Return code: 0 03:56:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:56:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:35 INFO - https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:56:39 INFO - Downloaded 23883193 bytes. 03:56:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:56:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:56:40 INFO - Return code: 0 03:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:40 INFO - https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:56:42 INFO - Downloaded 10840152 bytes. 03:56:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:56:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:56:42 INFO - Return code: 0 03:56:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:42 INFO - https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:56:45 INFO - Downloaded 58428445 bytes. 03:56:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:56:45 INFO - mkdir: /builds/slave/test/properties 03:56:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:56:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:56:45 INFO - Contents: 03:56:45 INFO - build_url:https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:56:46 INFO - Running post-action listener: _resource_record_post_action 03:56:46 INFO - Running post-action listener: set_extra_try_arguments 03:56:46 INFO - ##### 03:56:46 INFO - ##### Finished download-and-extract step (success) 03:56:46 INFO - ##### 03:56:46 INFO - ##### 03:56:46 INFO - ##### Running populate-webroot step. 03:56:46 INFO - ##### 03:56:46 INFO - Running pre-action listener: _resource_record_pre_action 03:56:46 INFO - Running main action method: populate_webroot 03:56:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:56:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:56:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:56:46 INFO - '--tppagecycles', 03:56:46 INFO - '7'], 03:56:46 INFO - 'tests': ['tsvgm']}}, 03:56:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:56:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:56:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:56:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:56:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:46 INFO - 'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:46 INFO - 'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['damp', 'tps']}, 03:56:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:46 INFO - 'tests': ['damp', 'tps']}, 03:56:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['dromaeo_dom']}, 03:56:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:56:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['a11yr', 03:56:46 INFO - 'ts_paint', 03:56:46 INFO - 'tpaint', 03:56:46 INFO - 'sessionrestore', 03:56:46 INFO - 'sessionrestore_no_auto_restore', 03:56:46 INFO - 'tabpaint']}, 03:56:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:56:46 INFO - 'ts_paint', 03:56:46 INFO - 'tpaint', 03:56:46 INFO - 'sessionrestore', 03:56:46 INFO - 'sessionrestore_no_auto_restore', 03:56:46 INFO - 'tabpaint']}, 03:56:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:56:46 INFO - 'ts_paint', 03:56:46 INFO - 'tpaint', 03:56:46 INFO - 'sessionrestore', 03:56:46 INFO - 'sessionrestore_no_auto_restore', 03:56:46 INFO - 'tabpaint']}, 03:56:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:56:46 INFO - 'ts_paint', 03:56:46 INFO - 'tpaint', 03:56:46 INFO - 'sessionrestore', 03:56:46 INFO - 'sessionrestore_no_auto_restore', 03:56:46 INFO - 'tabpaint']}, 03:56:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['a11yr', 03:56:46 INFO - 'ts_paint', 03:56:46 INFO - 'tpaint', 03:56:46 INFO - 'sessionrestore', 03:56:46 INFO - 'sessionrestore_no_auto_restore', 03:56:46 INFO - 'tabpaint']}, 03:56:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['a11yr', 03:56:46 INFO - 'ts_paint', 03:56:46 INFO - 'tpaint', 03:56:46 INFO - 'sessionrestore', 03:56:46 INFO - 'sessionrestore_no_auto_restore', 03:56:46 INFO - 'tabpaint']}, 03:56:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['tsvgx', 03:56:46 INFO - 'tsvgr_opacity', 03:56:46 INFO - 'tart', 03:56:46 INFO - 'tscrollx', 03:56:46 INFO - 'cart']}, 03:56:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:56:46 INFO - 'tsvgr_opacity', 03:56:46 INFO - 'tart', 03:56:46 INFO - 'tscrollx', 03:56:46 INFO - 'cart']}, 03:56:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:46 INFO - 'talos_options': ['--disable-e10s'], 03:56:46 INFO - 'tests': ['tp5o']}, 03:56:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:46 INFO - 'tests': ['tp5o']}, 03:56:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:46 INFO - 'talos_options': ['--disable-e10s', 03:56:46 INFO - '--xperf_path', 03:56:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:46 INFO - 'tests': ['tp5n']}, 03:56:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:46 INFO - 'talos_options': ['--xperf_path', 03:56:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:46 INFO - 'tests': ['tp5n']}}, 03:56:46 INFO - 'talos.zip': {'path': '', 03:56:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:56:46 INFO - Running post-action listener: _resource_record_post_action 03:56:46 INFO - ##### 03:56:46 INFO - ##### Finished populate-webroot step (success) 03:56:46 INFO - ##### 03:56:46 INFO - ##### 03:56:46 INFO - ##### Running create-virtualenv step. 03:56:46 INFO - ##### 03:56:46 INFO - Running pre-action listener: _resource_record_pre_action 03:56:46 INFO - Running main action method: create_virtualenv 03:56:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:56:46 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 03:56:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:56:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:56:46 INFO - Using real prefix '/usr' 03:56:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:56:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:56:48 INFO - Installing pip.................done. 03:56:48 INFO - Return code: 0 03:56:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:56:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:48 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 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:56:48 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 03:56:48 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 03:56:48 INFO - Using env: {'DISPLAY': ':0', 03:56:48 INFO - 'HOME': '/home/cltbld', 03:56:48 INFO - 'LANG': 'en_US.UTF-8', 03:56:48 INFO - 'LANGUAGE': 'en_US:en', 03:56:48 INFO - 'LOGNAME': 'cltbld', 03:56:48 INFO - 'MAIL': '/var/mail/cltbld', 03:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:48 INFO - 'MOZ_NO_REMOTE': '1', 03:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:48 INFO - 'NO_EM_RESTART': '1', 03:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:48 INFO - 'PWD': '/builds/slave/test', 03:56:48 INFO - 'SHELL': '/bin/bash', 03:56:48 INFO - 'SHLVL': '1', 03:56:48 INFO - 'TERM': 'linux', 03:56:48 INFO - 'TMOUT': '86400', 03:56:48 INFO - 'USER': 'cltbld', 03:56:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:48 INFO - '_': '/tools/buildbot/bin/python'} 03:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:48 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 03:56:48 INFO - Cleaning up... 03:56:48 INFO - Return code: 0 03:56:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:56:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:48 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:56:48 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>=0.7.1'] in /builds/slave/test/build 03:56:48 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>=0.7.1 03:56:48 INFO - Using env: {'DISPLAY': ':0', 03:56:48 INFO - 'HOME': '/home/cltbld', 03:56:48 INFO - 'LANG': 'en_US.UTF-8', 03:56:48 INFO - 'LANGUAGE': 'en_US:en', 03:56:48 INFO - 'LOGNAME': 'cltbld', 03:56:48 INFO - 'MAIL': '/var/mail/cltbld', 03:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:48 INFO - 'MOZ_NO_REMOTE': '1', 03:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:48 INFO - 'NO_EM_RESTART': '1', 03:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:48 INFO - 'PWD': '/builds/slave/test', 03:56:48 INFO - 'SHELL': '/bin/bash', 03:56:48 INFO - 'SHLVL': '1', 03:56:48 INFO - 'TERM': 'linux', 03:56:48 INFO - 'TMOUT': '86400', 03:56:48 INFO - 'USER': 'cltbld', 03:56:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:48 INFO - '_': '/tools/buildbot/bin/python'} 03:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:49 INFO - Downloading/unpacking psutil>=0.7.1 03:56:49 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 03:56:49 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 03:56:49 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 03:56:49 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 03:56:49 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 03:56:49 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 03:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:51 INFO - Installing collected packages: psutil 03:56:51 INFO - Running setup.py install for psutil 03:56:51 INFO - building 'psutil._psutil_linux' extension 03:56:51 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 03:56:51 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 03:56:51 INFO - building 'psutil._psutil_posix' extension 03:56:51 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 03:56:51 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 03:56:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:51 INFO - Successfully installed psutil 03:56:51 INFO - Cleaning up... 03:56:51 INFO - Return code: 0 03:56:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:56:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:51 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:56:51 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.0.0'] in /builds/slave/test/build 03:56:51 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.0.0 03:56:51 INFO - Using env: {'DISPLAY': ':0', 03:56:51 INFO - 'HOME': '/home/cltbld', 03:56:51 INFO - 'LANG': 'en_US.UTF-8', 03:56:51 INFO - 'LANGUAGE': 'en_US:en', 03:56:51 INFO - 'LOGNAME': 'cltbld', 03:56:51 INFO - 'MAIL': '/var/mail/cltbld', 03:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:51 INFO - 'MOZ_NO_REMOTE': '1', 03:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:51 INFO - 'NO_EM_RESTART': '1', 03:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:51 INFO - 'PWD': '/builds/slave/test', 03:56:51 INFO - 'SHELL': '/bin/bash', 03:56:51 INFO - 'SHLVL': '1', 03:56:51 INFO - 'TERM': 'linux', 03:56:51 INFO - 'TMOUT': '86400', 03:56:51 INFO - 'USER': 'cltbld', 03:56:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:51 INFO - '_': '/tools/buildbot/bin/python'} 03:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:56:51 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 03:56:51 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 03:56:51 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 03:56:51 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 03:56:51 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 03:56:51 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 03:56:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:56:53 INFO - Installing collected packages: mozsystemmonitor 03:56:53 INFO - Running setup.py install for mozsystemmonitor 03:56:53 INFO - Successfully installed mozsystemmonitor 03:56:53 INFO - Cleaning up... 03:56:53 INFO - Return code: 0 03:56:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:56:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:53 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 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:56:53 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 03:56:53 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 03:56:53 INFO - Using env: {'DISPLAY': ':0', 03:56:53 INFO - 'HOME': '/home/cltbld', 03:56:53 INFO - 'LANG': 'en_US.UTF-8', 03:56:53 INFO - 'LANGUAGE': 'en_US:en', 03:56:53 INFO - 'LOGNAME': 'cltbld', 03:56:53 INFO - 'MAIL': '/var/mail/cltbld', 03:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:53 INFO - 'MOZ_NO_REMOTE': '1', 03:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:53 INFO - 'NO_EM_RESTART': '1', 03:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:53 INFO - 'PWD': '/builds/slave/test', 03:56:53 INFO - 'SHELL': '/bin/bash', 03:56:53 INFO - 'SHLVL': '1', 03:56:53 INFO - 'TERM': 'linux', 03:56:53 INFO - 'TMOUT': '86400', 03:56:53 INFO - 'USER': 'cltbld', 03:56:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:53 INFO - '_': '/tools/buildbot/bin/python'} 03:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:56:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:56:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 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 03:56:56 INFO - Downloading docopt-0.6.1.tar.gz 03:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:56:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:56:56 INFO - Running setup.py install for blobuploader 03:56:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:56:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:56:56 INFO - Running setup.py install for requests 03:56:57 INFO - Running setup.py install for docopt 03:56:57 INFO - Successfully installed blobuploader requests docopt 03:56:57 INFO - Cleaning up... 03:56:57 INFO - Return code: 0 03:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:57 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 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:56:57 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 03:56:57 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 03:56:57 INFO - Using env: {'DISPLAY': ':0', 03:56:57 INFO - 'HOME': '/home/cltbld', 03:56:57 INFO - 'LANG': 'en_US.UTF-8', 03:56:57 INFO - 'LANGUAGE': 'en_US:en', 03:56:57 INFO - 'LOGNAME': 'cltbld', 03:56:57 INFO - 'MAIL': '/var/mail/cltbld', 03:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:57 INFO - 'MOZ_NO_REMOTE': '1', 03:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:57 INFO - 'NO_EM_RESTART': '1', 03:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:57 INFO - 'PWD': '/builds/slave/test', 03:56:57 INFO - 'SHELL': '/bin/bash', 03:56:57 INFO - 'SHLVL': '1', 03:56:57 INFO - 'TERM': 'linux', 03:56:57 INFO - 'TMOUT': '86400', 03:56:57 INFO - 'USER': 'cltbld', 03:56:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:57 INFO - '_': '/tools/buildbot/bin/python'} 03:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:57 INFO - Running setup.py (path:/tmp/pip-lXkJNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:57 INFO - Running setup.py (path:/tmp/pip-Sqbj1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:57 INFO - Running setup.py (path:/tmp/pip-oVvbAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:57 INFO - Running setup.py (path:/tmp/pip-lubVMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:57 INFO - Running setup.py (path:/tmp/pip-dK1BBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:57 INFO - Running setup.py (path:/tmp/pip-ZJZPL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:58 INFO - Running setup.py (path:/tmp/pip-X5ROgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:58 INFO - Running setup.py (path:/tmp/pip-bPFLTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:58 INFO - Running setup.py (path:/tmp/pip-x0QY0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:58 INFO - Running setup.py (path:/tmp/pip-LTgEty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:58 INFO - Running setup.py (path:/tmp/pip-H0nHGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:58 INFO - Running setup.py (path:/tmp/pip-Bap2UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:58 INFO - Running setup.py (path:/tmp/pip-2YiOPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:58 INFO - Running setup.py (path:/tmp/pip-vQ32pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:58 INFO - Running setup.py (path:/tmp/pip-Iu0Q9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:58 INFO - Running setup.py (path:/tmp/pip-9dA4qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:58 INFO - Running setup.py (path:/tmp/pip-g0Ioym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:58 INFO - Running setup.py install for manifestparser 03:56:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:56:58 INFO - Running setup.py install for mozcrash 03:56:59 INFO - Running setup.py install for mozdebug 03:56:59 INFO - Running setup.py install for mozdevice 03:56:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Running setup.py install for mozfile 03:56:59 INFO - Running setup.py install for mozhttpd 03:56:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Running setup.py install for mozinfo 03:56:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Running setup.py install for mozInstall 03:56:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Running setup.py install for mozleak 03:56:59 INFO - Running setup.py install for mozlog 03:56:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Running setup.py install for moznetwork 03:56:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:56:59 INFO - Running setup.py install for mozprocess 03:57:00 INFO - Running setup.py install for mozprofile 03:57:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:00 INFO - Running setup.py install for mozrunner 03:57:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:00 INFO - Running setup.py install for mozscreenshot 03:57:00 INFO - Running setup.py install for moztest 03:57:00 INFO - Running setup.py install for mozversion 03:57:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:00 INFO - Cleaning up... 03:57:00 INFO - Return code: 0 03:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:00 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 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:57:00 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 03:57:00 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 03:57:00 INFO - Using env: {'DISPLAY': ':0', 03:57:00 INFO - 'HOME': '/home/cltbld', 03:57:00 INFO - 'LANG': 'en_US.UTF-8', 03:57:00 INFO - 'LANGUAGE': 'en_US:en', 03:57:00 INFO - 'LOGNAME': 'cltbld', 03:57:00 INFO - 'MAIL': '/var/mail/cltbld', 03:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:00 INFO - 'MOZ_NO_REMOTE': '1', 03:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:00 INFO - 'NO_EM_RESTART': '1', 03:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:00 INFO - 'PWD': '/builds/slave/test', 03:57:00 INFO - 'SHELL': '/bin/bash', 03:57:00 INFO - 'SHLVL': '1', 03:57:00 INFO - 'TERM': 'linux', 03:57:00 INFO - 'TMOUT': '86400', 03:57:00 INFO - 'USER': 'cltbld', 03:57:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:00 INFO - '_': '/tools/buildbot/bin/python'} 03:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:00 INFO - Running setup.py (path:/tmp/pip-UeyWZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:00 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)) 03:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:00 INFO - Running setup.py (path:/tmp/pip-2UKa3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:01 INFO - Running setup.py (path:/tmp/pip-_NrfCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:01 INFO - Running setup.py (path:/tmp/pip-oeyaUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:01 INFO - Running setup.py (path:/tmp/pip-Ev5amg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:01 INFO - Running setup.py (path:/tmp/pip-WU3d2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:01 INFO - Running setup.py (path:/tmp/pip-FidF59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:01 INFO - Running setup.py (path:/tmp/pip-ixCV0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:01 INFO - Running setup.py (path:/tmp/pip-3fRHeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:01 INFO - Running setup.py (path:/tmp/pip-au8HOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:01 INFO - Running setup.py (path:/tmp/pip-mGxt1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:01 INFO - Running setup.py (path:/tmp/pip-6CTFLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:01 INFO - Running setup.py (path:/tmp/pip-03RxNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:01 INFO - Running setup.py (path:/tmp/pip-8A8Z2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:01 INFO - Running setup.py (path:/tmp/pip-ORGRSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:01 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)) 03:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:01 INFO - Running setup.py (path:/tmp/pip-9y1Opf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:02 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)) 03:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:02 INFO - Running setup.py (path:/tmp/pip-NHvXLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:02 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)) 03:57:02 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)) 03:57:02 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)) 03:57:02 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)) 03:57:02 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)) 03:57:02 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)) 03:57:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57:02 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 03:57:02 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 03:57:02 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 03:57:02 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 03:57:02 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 03:57:02 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 03:57:04 INFO - Downloading blessings-1.6.tar.gz 03:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:57:04 INFO - Installing collected packages: blessings 03:57:04 INFO - Running setup.py install for blessings 03:57:04 INFO - Successfully installed blessings 03:57:04 INFO - Cleaning up... 03:57:04 INFO - Return code: 0 03:57:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:04 INFO - Reading from file tmpfile_stdout 03:57:04 INFO - Current package versions: 03:57:04 INFO - argparse == 1.2.1 03:57:04 INFO - blessings == 1.6 03:57:04 INFO - blobuploader == 1.2.4 03:57:04 INFO - docopt == 0.6.1 03:57:04 INFO - manifestparser == 1.1 03:57:04 INFO - mozInstall == 1.12 03:57:04 INFO - mozcrash == 0.17 03:57:04 INFO - mozdebug == 0.1 03:57:04 INFO - mozdevice == 0.48 03:57:04 INFO - mozfile == 1.2 03:57:04 INFO - mozhttpd == 0.7 03:57:04 INFO - mozinfo == 0.9 03:57:04 INFO - mozleak == 0.1 03:57:04 INFO - mozlog == 3.1 03:57:04 INFO - moznetwork == 0.27 03:57:04 INFO - mozprocess == 0.22 03:57:04 INFO - mozprofile == 0.28 03:57:04 INFO - mozrunner == 6.11 03:57:04 INFO - mozscreenshot == 0.1 03:57:04 INFO - mozsystemmonitor == 0.0 03:57:04 INFO - moztest == 0.7 03:57:04 INFO - mozversion == 1.4 03:57:04 INFO - psutil == 3.1.1 03:57:04 INFO - requests == 1.2.3 03:57:04 INFO - wsgiref == 0.1.2 03:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:04 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 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:57:04 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 03:57:04 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 03:57:04 INFO - Using env: {'DISPLAY': ':0', 03:57:04 INFO - 'HOME': '/home/cltbld', 03:57:04 INFO - 'LANG': 'en_US.UTF-8', 03:57:04 INFO - 'LANGUAGE': 'en_US:en', 03:57:04 INFO - 'LOGNAME': 'cltbld', 03:57:04 INFO - 'MAIL': '/var/mail/cltbld', 03:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:04 INFO - 'MOZ_NO_REMOTE': '1', 03:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:04 INFO - 'NO_EM_RESTART': '1', 03:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:04 INFO - 'PWD': '/builds/slave/test', 03:57:04 INFO - 'SHELL': '/bin/bash', 03:57:04 INFO - 'SHLVL': '1', 03:57:04 INFO - 'TERM': 'linux', 03:57:04 INFO - 'TMOUT': '86400', 03:57:04 INFO - 'USER': 'cltbld', 03:57:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:04 INFO - '_': '/tools/buildbot/bin/python'} 03:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 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)) 03:57:04 INFO - Cleaning up... 03:57:04 INFO - Return code: 0 03:57:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:57: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', 'jsonschema'] in /builds/slave/test/build 03:57: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 jsonschema 03:57:04 INFO - Using env: {'DISPLAY': ':0', 03:57:04 INFO - 'HOME': '/home/cltbld', 03:57:04 INFO - 'LANG': 'en_US.UTF-8', 03:57:04 INFO - 'LANGUAGE': 'en_US:en', 03:57:04 INFO - 'LOGNAME': 'cltbld', 03:57:04 INFO - 'MAIL': '/var/mail/cltbld', 03:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:04 INFO - 'MOZ_NO_REMOTE': '1', 03:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:04 INFO - 'NO_EM_RESTART': '1', 03:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:04 INFO - 'PWD': '/builds/slave/test', 03:57:04 INFO - 'SHELL': '/bin/bash', 03:57:04 INFO - 'SHLVL': '1', 03:57:04 INFO - 'TERM': 'linux', 03:57:04 INFO - 'TMOUT': '86400', 03:57:04 INFO - 'USER': 'cltbld', 03:57:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:04 INFO - '_': '/tools/buildbot/bin/python'} 03:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:04 INFO - Downloading/unpacking jsonschema 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:06 INFO - Downloading/unpacking functools32 (from jsonschema) 03:57:06 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 03:57:06 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 03:57:06 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 03:57:06 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 03:57:06 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 03:57:06 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 03:57:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:07 INFO - warning: no files found matching '*.txt' 03:57:07 INFO - no previously-included directories found matching 'build' 03:57:07 INFO - no previously-included directories found matching 'dist' 03:57:07 INFO - no previously-included directories found matching '.git*' 03:57:07 INFO - Installing collected packages: jsonschema, functools32 03:57:07 INFO - Running setup.py install for functools32 03:57:07 INFO - warning: no files found matching '*.txt' 03:57:07 INFO - no previously-included directories found matching 'build' 03:57:07 INFO - no previously-included directories found matching 'dist' 03:57:07 INFO - no previously-included directories found matching '.git*' 03:57:07 INFO - Successfully installed jsonschema functools32 03:57:07 INFO - Cleaning up... 03:57:07 INFO - Return code: 0 03:57:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:57:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:07 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46fecfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, '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': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', '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 03:57:07 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', 'flake8'] in /builds/slave/test/build 03:57:07 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 flake8 03:57:07 INFO - Using env: {'DISPLAY': ':0', 03:57:07 INFO - 'HOME': '/home/cltbld', 03:57:07 INFO - 'LANG': 'en_US.UTF-8', 03:57:07 INFO - 'LANGUAGE': 'en_US:en', 03:57:07 INFO - 'LOGNAME': 'cltbld', 03:57:07 INFO - 'MAIL': '/var/mail/cltbld', 03:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:07 INFO - 'MOZ_NO_REMOTE': '1', 03:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:07 INFO - 'NO_EM_RESTART': '1', 03:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:07 INFO - 'PWD': '/builds/slave/test', 03:57:07 INFO - 'SHELL': '/bin/bash', 03:57:07 INFO - 'SHLVL': '1', 03:57:07 INFO - 'TERM': 'linux', 03:57:07 INFO - 'TMOUT': '86400', 03:57:07 INFO - 'USER': 'cltbld', 03:57:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:07 INFO - '_': '/tools/buildbot/bin/python'} 03:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:07 INFO - Downloading/unpacking flake8 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:57:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:57:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:57:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:57:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:57:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:57:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:57:10 INFO - no previously-included directories found matching 'docs/_build' 03:57:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:57:10 INFO - Running setup.py install for pep8 03:57:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:57:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:57:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:57:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:57:10 INFO - no previously-included directories found matching 'docs/_build' 03:57:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:57:10 INFO - Cleaning up... 03:57:10 INFO - Return code: 0 03:57:10 INFO - Running post-action listener: _resource_record_post_action 03:57:10 INFO - Running post-action listener: _start_resource_monitoring 03:57:10 INFO - Starting resource monitoring. 03:57:10 INFO - ##### 03:57:10 INFO - ##### Finished create-virtualenv step (success) 03:57:10 INFO - ##### 03:57:10 INFO - ##### 03:57:10 INFO - ##### Running install step. 03:57:10 INFO - ##### 03:57:10 INFO - Running pre-action listener: _resource_record_pre_action 03:57:10 INFO - Running main action method: install 03:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:10 INFO - Reading from file tmpfile_stdout 03:57:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:57:10 INFO - Reading from file tmpfile_stdout 03:57:10 INFO - Output received: 03:57:10 INFO - Usage: mozinstall [options] installer 03:57:10 INFO - Options: 03:57:10 INFO - -h, --help show this help message and exit 03:57:10 INFO - -d DEST, --destination=DEST 03:57:10 INFO - Directory to install application into. [default: 03:57:10 INFO - "/builds/slave/test"] 03:57:10 INFO - --app=APP Application being installed. [default: firefox] 03:57:10 INFO - mkdir: /builds/slave/test/build/application 03:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:57:27 INFO - Reading from file tmpfile_stdout 03:57:27 INFO - Output received: 03:57:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:57:27 INFO - Running post-action listener: _resource_record_post_action 03:57:27 INFO - ##### 03:57:27 INFO - ##### Finished install step (success) 03:57:27 INFO - ##### 03:57:27 INFO - ##### 03:57:27 INFO - ##### Running run-tests step. 03:57:27 INFO - ##### 03:57:27 INFO - Running pre-action listener: _resource_record_pre_action 03:57:27 INFO - Running main action method: run_tests 03:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:27 INFO - Python 2.7.3 03:57:27 INFO - Return code: 0 03:57:27 INFO - grabbing minidump binary from tooltool 03:57:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:27 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239b410>, '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 0x239c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:27 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 03:57:27 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 03:57:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:27 INFO - Return code: 0 03:57:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:57:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:57:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:57:28 INFO - Return code: 0 03:57:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:57:28 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:57:28 INFO - Using env: {'DISPLAY': ':0', 03:57:28 INFO - 'HOME': '/home/cltbld', 03:57:28 INFO - 'LANG': 'en_US.UTF-8', 03:57:28 INFO - 'LANGUAGE': 'en_US:en', 03:57:28 INFO - 'LOGNAME': 'cltbld', 03:57:28 INFO - 'MAIL': '/var/mail/cltbld', 03:57:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:28 INFO - 'MOZ_NO_REMOTE': '1', 03:57:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:28 INFO - 'NO_EM_RESTART': '1', 03:57:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:28 INFO - 'PWD': '/builds/slave/test', 03:57:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:28 INFO - 'SHELL': '/bin/bash', 03:57:28 INFO - 'SHLVL': '1', 03:57:28 INFO - 'TERM': 'linux', 03:57:28 INFO - 'TMOUT': '86400', 03:57:28 INFO - 'USER': 'cltbld', 03:57:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462532075.292321-620422555', 03:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:28 INFO - '_': '/tools/buildbot/bin/python'} 03:57:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:57:28 INFO - mozversion application_buildid: 20160506013026 03:57:28 INFO - mozversion application_changeset: 5896e929871bb58cf454238bcf82bff6c906e834 03:57:28 INFO - mozversion application_display_name: Nightly 03:57:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:28 INFO - mozversion application_name: Firefox 03:57:28 INFO - mozversion application_remotingname: firefox 03:57:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:57:28 INFO - mozversion application_vendor: Mozilla 03:57:28 INFO - mozversion application_version: 49.0a1 03:57:28 INFO - mozversion platform_buildid: 20160506013026 03:57:28 INFO - mozversion platform_changeset: 5896e929871bb58cf454238bcf82bff6c906e834 03:57:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:57:28 INFO - mozversion platform_version: 49.0a1 03:57:28 INFO - using testdate: 1462532248 03:57:28 INFO - actual date: 1462532248 03:57:28 INFO - starting webserver on 'localhost:50377' 03:57:28 INFO - SUITE-START | Running 2 tests 03:57:28 INFO - TEST-START | dromaeo_css 03:57:28 INFO - operating with platform_type : linux_ 03:57:28 INFO - Initialising browser for dromaeo_css test... 03:57:28 INFO - TEST-INFO | started process 23842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpndzBti/profile http://localhost:50377/getInfo.html) 03:57:32 INFO - PROCESS | 23842 | __metrics Screen width/height:1600/1200 03:57:32 INFO - PROCESS | 23842 | colorDepth:24 03:57:32 INFO - PROCESS | 23842 | Browser inner width/height: 1024/697 03:57:32 INFO - PROCESS | 23842 | __metrics 03:57:33 ERROR - PROCESS | 23842 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:57:34 INFO - TEST-INFO | 23842: exit 0 03:57:34 INFO - Browser initialized. 03:57:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:57:34 INFO - TEST-INFO | started process 23925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpndzBti/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:46 INFO - PROCESS | 23925 | RSS: Main: 152113152 03:57:46 INFO - PROCESS | 23925 | 03:58:37 INFO - PROCESS | 23925 | 1462532317242 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] 04:00:45 INFO - PROCESS | 23925 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50377/tests/dromaeo/cssquery-ext.html) 04:00:46 INFO - PROCESS | 23925 | RSS: Main: 243490816 04:00:46 INFO - PROCESS | 23925 | 04:03:48 INFO - PROCESS | 23925 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-ext.html (next: http://localhost:50377/tests/dromaeo/cssquery-jquery.html) 04:03:49 INFO - PROCESS | 23925 | RSS: Main: 240955392 04:03:49 INFO - PROCESS | 23925 | 04:06:50 INFO - PROCESS | 23925 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50377/tests/dromaeo/cssquery-mootools.html) 04:06:51 INFO - PROCESS | 23925 | RSS: Main: 249311232 04:06:51 INFO - PROCESS | 23925 | 04:09:53 INFO - PROCESS | 23925 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50377/tests/dromaeo/cssquery-prototype.html) 04:09:54 INFO - PROCESS | 23925 | RSS: Main: 238833664 04:09:54 INFO - PROCESS | 23925 | 04:12:56 INFO - PROCESS | 23925 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50377/tests/dromaeo/cssquery-yui.html) 04:12:57 INFO - PROCESS | 23925 | RSS: Main: 222343168 04:12:57 INFO - PROCESS | 23925 | 04:15:59 INFO - PROCESS | 23925 | Cycle 1(1): loaded http://localhost:50377/tests/dromaeo/cssquery-yui.html (next: http://localhost:50377/tests/dromaeo/cssquery-dojo.html) 04:16:00 INFO - PROCESS | 23925 | RSS: Main: 314429440 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - PROCESS | 23925 | __start_tp_report 04:16:00 INFO - PROCESS | 23925 | _x_x_mozilla_page_load 04:16:00 INFO - PROCESS | 23925 | _x_x_mozilla_page_load_details 04:16:00 INFO - PROCESS | 23925 | |i|pagename|runs| 04:16:00 INFO - PROCESS | 23925 | |0;dojo.html;3112.1286039908828;3143.497040473523;3158.0841555948778;3179.523071539267;3209.6790320967907;5184.974075129629;5226.189940559215;5234.528892399683;5343.225232341313;5352.892942141155;5268.446813084628;5273.5781137509;5281.603879709018;5350.705711185883;5352.57179425646;4742.7865746041425;4822.107910036637;4866.878328041792;4876.463589005207;5002.249662550628;4899.265110233458;4967.950320496803;4981.476944920785;4981.651284410093;4998.200287953928;4632.351470794091;4788.97605511972;4809.879753006167;4838.153323168449;4843.15244832153;4852.927206091911;4857.878553036167;4867.586255168315;4873.269009648581;4910.8281210157475;4658.1848176568965;4834.709917404932;4853.126437241295;4856.587190088847;4890.437599676047;5193.506616871391;5252.947470525284;5255.421903590602;5313.8937221255355;5336.039512887679;5715.914261286042;5778.219940308047;5781.959247335478;5786.68173250471;5792.4497172768515;5496.120620700709;5665.631733937281;5800.680962547058;5848.766049358021;5854.443827836349;5306.52241298285;5376.462353764592;5424.105022671254;5425.050616142199;5431.402545719968;5919.230500034968;5960.314563825129;5964.821055368346;5968.940310596925;5978.55160862937;5397.406285308692;5511;5552.7223638817895;5719.971400142973;5723.685197314105;5679.630823996427;5682.54539636828;5684.062129748545;5693.202951586781;5723.084306510938;5626.549876009909;5644.6613203207935;5667.546596272288;5669.262995810518;5674.375818659944;5372.838814835562;5573.470520300565;5599.608027438122;5623.718814059363;5647.463490968352;4333.631641310524;4346.7609281489185;4346.8043938022865;4358.782060896942;4377.474703035656;3867.106728169245;3889.202713443737;3907.1208977980295;3939.153082087365;3959.802009899551;5120.7951681933055;5172.637915345965;5291.920621190685;5324.893502129936;5376.46235376467;5690.317161940594;5707.74315155819;5708.857278567986;5717.857053573611;5722.570807189478;5398.325209348832;5409.918851217235;5411.729413529308;5411.864703382368;5454.427285135083;4772.093302272627;4886.7067975920845;4909.337239472697;4916.336294600254;4989.027139707722;5920.319163296276;5922.437368449991;5930.940690593039;5938;5951.226340575698;5699.116636921284;5713.200151978809;5716.114002329646;5718.656880587178;5719.999000174953;5638.548916086621;5854.180414742024;5931.495822854933;5949.167116603766;5980.820575382745;5617.831465056055;5642.379338272704;5662.405447428126;5665.49010589049;5672.943270567242;5433.130699088127;5731.254936858182;5731.5128214100605;5732.656040637575;5743.4543718346695;5392.649477783932;5525.696086715108;5582.748776304995;5589.077802162597;5650.660960342392;5613.298337707786;5631.971840140773;5632.352279487911;5633;5634.070378387521;5225.738713064407;5518.724063796713;5518.779248830162;5534.308211473566;5534.584906132137;5532.889342213214;5588.636738611977;5603.271574695264;5679;5682.602217844711;5474.945250547444;5499.5325397340075;5508.862278443071;5518.448155184449;5549.861253468695 04:16:00 INFO - PROCESS | 23925 | |1;ext.html;635.7043974551832;642.6690254518923;644.4007073421716;652.3834975947725;657.6120089147402;30556.69443305569;33807;43936;44638.77680611592;44798.77600612;44447;44957;44983;44993.325100123526;45000.09999800002;8753.562321883895;8912.643494260254;8928.107189281085;8928.151825576593;8931;8788.296936245086;8894.955525222396;8897.68858089967;8901.910980890205;8909.198172164504;8685.218330350268;8707.782305442382;8712.520811355405;8713.477191368538;8720.563971801415;8842.911570884273;8876.822463550758;8879.289656827503;8885.46687198767;8886.111388861127;8782.780430489289;8873.757673925655;8875.511846848422;8877.33419993503;8881.245094167003;41513.37729934054;42262;42274.78862605698;42281.78859105716;42360;3609.404448266033;3725.832337544817;3778.9055273618105;3849.5957924418094;3885.4560361549406;31275.687243127733;31450;31939.6806031939;32131.678683213104;32816.6718332816;4318.654507639413;4358.782060896942;4409.603135717801;4417.469903611587;4435.866923992253;326376;326688;327006;331511.9999999976;332330;60382.39617603856;61498;61599.38400616026;61633;61659.691701541204;56397.43602563922;57780;57782.422175777705;58046.32467266234;61821.381786182465;16529.504114876574;16579.6684066318;16703.91648041752;16708.41520546775;16733.665326693397;11300.547978080785;12773.61679149627;12867.935660321638;12881.420336084899;12882.291473969022;19173.712394314098;19515.74187508103;20179.697304540445;20221.898890505454;20359.898200508902;6918.5502942309595;7045.365917067488;7124.684477544819;7337.486375953632;7489.662965166581;1020.831562792131;1044.4307852220559;1057.3285963413289;1059.5338051257422;1234.7407044520571;32006;32327;32439.837800811318;32516.187095322806;32743.50884736731;1148.1847887999447;1183.0653783511102;1195.2529668956902;1208.957686480969;1249.0694432647736;16701.374427321978;16785.496435106965;16806.663866722596;16819.495415137564;16970.830291697173;481164;485311;485411;485653;487275;57338;58573;58585;58600;58640;1415.929203539819;1420.0911416693325;1431.0698046270008;1443.0620096937075;1460.7224627320988;30041.699583004764;30398;31251;31476.842615786776;31850.681493184773;49213;49495.25757113574;49898.251526226406;49909.75045124751;49915.50084499254;394367;397795;398489;398802;399589;24955;27359.179224623294;27942;27961.44077118487;28117.859410702815;46815;47015.764921176546;47168;47445.762771185924;48268;40479;40909;41078.58921410867;41444;41914.37128443015;39679.80160099296;39716.404253936795;40894.79552602337;41143.38284925788;41263;39658.20683586255;41782.58217417787;42347.364789527564;42715.78642106769;42988.570114298454;34724.82637586796;36499.635003650685;36773.26453470969;37404.81297593604;37889;28676;28757.85621071881;28960.710392895802;29184.56223156612;29413.411731765675 04:16:00 INFO - PROCESS | 23925 | |2;jquery.html;407.29944495467794;413.2520138549228;413.3840577539467;415.4619767401215;424.53089336283404;17367.65264694707;19036;19166.520836979063;19184.99999999998;20202.797972020275;17350.56623584411;17682.11589420527;17829.197686104126;17855.821441785578;17904.194311255993;5634.32388113427;5641.266635337401;5747.195392645033;5798.594098413113;5823.883522329551;5701.800436984707;5751.05107657236;5751.7986870459545;5753.568482363839;5773.740181691813;5536.640118392312;5718.542516598683;5746.569007324447;5787.189793428924;5797;5529.4470552944385;5726.68503232322;5745.885082298372;5761.222234998285;5781.046127388997;5075.111855425286;5082.79668813247;5089.389273287229;5089.974550127263;5115.104856650071;22188.55622887533;22250.554988900294;22656.660150097763;23159.652605210937;23224.187153449548;2224.2104053061253;2413.9396515087087;2472.7898128659085;2518.8236823422367;2586.6895972483235;10155.28912976092;10596.523156457977;11496.42517874103;14089.929550352284;14740.631484212874;1968.4685135013467;2023.9190432382686;2055.0444043519688;2056.8663036902703;2069.968950465744;80473.59763201205;84014;84262.15737842604;84484.57757711296;84643;10894.894954937805;10940.288881222854;11026.944865275622;11145.944270278596;11351.37567433799;15256.618584535254;15273.770893436607;15426.691466170838;15437;15444.227788610524;8118.715844945398;8236.135205803424;8273.296769774517;8351.707690230813;8421.284190843724;7955.164707705608;8095.392845536609;8104.675812967534;8389.874151887727;8415.74752757406;4500.189965806121;4684.508126646721;4728;4744.217204161275;4760.119377915097;1968.507873031742;1978.9010549472468;1983.5537004173946;2000.689893066577;2044.6830741235133;946.3801210207325;1068.7488440216543;1088.8312311591558;1096.2545469080942;1115.369816053927;18390.724139137925;18493.260269589067;18720.53198670044;18989;19425.320113795948;1019.3425240719695;1026.8973102689672;1027.3322340478599;1029.5572903651353;1047.1936608811172;10404.635837745642;10690.09134223584;10823.891761082446;10835.349879007284;10854.403007834488;468819;471053;471592;475004;488005;89186;91548;92676.53661731648;92788.53605731929;93386;1025.0979138358198;1043.6242952537082;1047.5547892145808;1057.39728354837;1060.7030031591166;16260.674786503967;16447.342106315613;16684.332626694795;16913.830861691225;17218.05300708473;37934.430983534716;38637.80681096577;38792.80603596964;39177.6082239174;40042.79978600088;51045.48954510407;51615.48384516107;54556.727216363666;59781.40218597758;61037.389626104945;7996.440249182734;8170.387220958571;8376.455530390505;8495.872561911452;8746;11456.484458199568;12400;12496.375181240719;12813.487460501476;12962.22226666403;11201.103911687209;11209.663710088711;11413.372264525531;11474.827877581676;11584.47869845842;5131.897362052663;10593.8876417975;11182.273152245078;11224.831627525757;11352.772944541228;10430.53062612169;11161.944190278997;11471.827922581335;11519.88480115188;11886.524539018688;8348.37387195975;8442.197991190827;8579.742607721779;8658;8701.651933922572;11359.602413915472;11405.087592992706;11463.656090317303;11646.94176529112;11794.115441341763 04:16:00 INFO - PROCESS | 23925 | |3;mootools.html;1330.241762195549;1549.3647604482157;1572.457502161754;1753.2986805277887;1872.1107473949867;8273.917260827397;8597.3122150228;8642.870356944652;8841.867371989409;8863.157999990006;8642.611082501287;8824.691135810248;8843.248323892476;8855.380123391365;8862.689805856797;1907.5040489472767;1952.453313072342;2183.192218879009;2232.5758105959817;2265.6035193841094;2245.9887700561476;2276.4081338851934;2276.6129757941108;2280.851744636602;2280.908763649452;2203.46015226269;2223.655333423322;2234.240358278185;2234.8882555872224;2240.8767517786514;1823.1522342110916;1870.8877467352002;1876.2682553804027;2071.7203177571137;2087.65553683642;2155.795199456049;2193.9561208775735;2197.04428573571;2200.3508964855405;2201.559688062394;8828.470291782514;8837.646494140226;8894.155055269739;8894.733158005205;8915.732528024104;5074.720890351029;5188.481151884819;5229.555487783543;5233.345831771028;5235.136202526579;3361;3421.4012547804036;3518.736094792901;3528.1356067763304;3553.342631613134;1124.7075760302298;1141.1156353825768;2134.7224860768156;2166.8483206175574;2185.2024011235944;11931.164818462712;12405.193662411913;12578.937105314415;12592.244465332018;12598.181118227287;4533.52397998212;4568.223402021665;4609.101225261042;4643.86068417948;4675.555822196886;9742.269329800152;9748.853767193497;9752.122308992082;9763.170130538841;9766.560504777302;5218.921716174261;5221.321228240305;5227.660202086929;5247.02929957959;5256.421793602701;4123.402106694512;4610.976945115253;4771.618270538418;4779.808807647724;4826.613870890391;3773.3019391412677;3781.4138808484727;3856.421536769451;3900.2004589059175;3928.9607103929166;1097.1825989637612;1145.6276710069094;1148.6726283009302;1149.9022583080364;1171.1392126786805;987.4667679453158;990.5599635473944;991.3209451525728;996.8704068471052;1004.5178314408978;5976.850578735566;6091.390860913873;6108.816735497942;6145.907811382833;6220.906686399708;434.8673654535334;443.80250788398854;444.4155934945536;445.31421610719775;447.985313265454;4024.7987600619854;4177.4778152730905;4231.767252801125;4272.594103560157;4296.548862369406;10556.683299501028;10984;11012.339259644446;11031.172662050378;11082.390468524147;10321.483925803679;10765.13878889687;10911.672649820519;10995.560177592966;11236.719082023015;8297.460665056873;8334.124916883882;8338.874916876252;8378.832423351621;8405.705800297083;5993.820185394445;6096.390360963868;6109.938900611115;6131.080337949344;6238.376162383725;10093.091621754078;10299.948500257451;10306;10374.481275936323;10419.739506512095;9959.900400996186;10247.795044099226;10558.419286939292;10671.786564268516;10674.412907290174;6943.097397338313;7591.924080759342;7785.455018148676;7962.442629015914;8076.111627721063;8406.87389689143;8450;8485.109063548238;8495.150484951455;8536.530490823065;7486.176520582841;7603.695852165852;7668.6165691716305;7715.652795624323;7736.497127686683;7522.811929701801;7629.54222746637;7656.540607563564;7791.181925897699;7808.453408261595;7045.542039767399;7101.857962840818;7120.181179164255;7122.821929451805;7123.7506687265695;5043.62172837046;5189.4032186299055;5259.421463639073;5320.973395133;5332.760025798771;5097.209932460474;5143.434222235626;5144.202648589475;5296.258523806593;5416.052190866504 04:16:00 INFO - PROCESS | 23925 | |4;prototype.html;336.9915752106197;343.92605589798205;347.5533938888529;354.01760115678974;354.5674277381595;5204;5214.817481388152;5229.450907654698;5245.291885595443;5265.657732247406;5140;5149.459306772782;5151.407588127367;5168.095583272921;5187.714675692835;3840.94509437451;3921.9215615687667;4066.8169932353117;4087.734297270668;4106;4050.2911990401562;4053.7973101344814;4056.391541268804;4070.1859628074358;4081.387791831234;3801.448789925473;4021.055052062763;4022.215667944737;4032.6370626643597;4036.3138266494766;3935.3900145477496;3976.403539469074;4071.7149799514045;4077.7553346799286;4080.5924504542168;3589.964100358989;3608.747387682863;3614.6927511161584;3619.2761447710564;3621.511096002059;5019.623528235397;5023.874403139914;5039.488153553956;5044.369453818273;5053.267276244961;4508.053308805155;4635.884102897421;4640.327152562893;4650.7442090685;4652.74409907455;5363.168708850135;5372.973135134299;5380.757865896044;5407.351117865842;5433.891322173535;3947.5262968443685;3956.5252169739815;3966.8214930327918;3974.2647610192207;3977.125032492847;5405.4324295949145;5622.297212848394;5622.859428514279;5629.240052592889;5643.802466913638;4006.7395619284653;4027.718059735849;4029.476168098187;4040.878773636796;4041.6766658667234;4038.7374820636564;4048.2105989332385;4081.69387295954;4091.1408604192857;4131.380292956021;4468.419105516262;4652.092841895866;4657.4876763555985;4688.578027977498;4703.247480403119;5369.543588794996;5399.325084364455;5454.3454785426;5455.8090466834265;5465.207544905967;1376.951806686781;1377.8415482219673;1387.361813565751;1387.4172847404116;1388.3752311459682;914.7301546043933;976.2141476111798;994.2096033653119;1001.5342865567401;1005.0301459092011;5030.496950305013;5063.443021267658;5084.51697088776;5100.464451232641;5117.155669314521;5316.388615309289;5349.652272602269;5398.6220964532895;5409.648372855751;5409.945900541023;4784.330193772875;5036.974815125975;5051.217061355495;5073.822416215415;5105.310783044316;2830.249983754307;2838.6451693538306;2854.915132249732;2869.9282517937218;2876.7123287671484;5590.413006634326;5628.212050312959;5628.97185514078;5643.529229523813;5666.631668941505;5275.525202731773;5432.782688692487;5458.727063646802;5464.726763661801;5510.669359838343;5449.6730196188355;5450.4549545045975;5476.452354764491;5562.749676264659;5590.86022849432;5260.08065523638;5355.27703760003;5362.865928351823;5368.711509237833;5404.432534583812;5510.972445137749;5521.266972848305;5541.224228608079;5563.693996830213;5566.888662226814;5782.421757824184;5799.884002320015;5822.573469499999;5840.415958404125;5857.531397488276;3873.1672690371706;3956.84172633103;3968.214303563466;3971.8411263550292;3987.342088555356;5567.693776842312;5570.749316280858;5584.441555844383;5590.664560126405;5605.775768969359;5428.430014848384;5432.158015507603;5470;5470.835874923759;5489.835304940858;5261.736913154404;5432.5110740032005;5435.374931882726;5460.044492213926;5482.369527504228;5144.717040562656;5380.650257733391;5389.487998640123;5396.64921780083;5413.891722165614;5311.920321195108;5459.543205557436;5471.452854714656;5483.972580137074;5543.778248870161;5348.9465105348445;5353.946460535345;5367.624266301322;5368.22160786676;5369.19462080691 04:16:00 INFO - PROCESS | 23925 | |5;yui.html;726.9164046134696;790.8457850719109;798.2815466080528;800.9839803203936;809.9352051835854;14266.144031358126;14405.927970360133;14587.854121458782;14686.265686715662;14703.411863525445;13765.655858603515;13821.101628394148;13821.585352439417;13830.723385532308;13831.446742130303;705.048184950318;824.9051359093706;828.200786241277;855.2260204514924;858.5492616376421;828.0022572799792;837.0165056059136;838.9412741108125;839.8404303182376;839.9874001889946;888.4802390601506;889.888763904512;889.9377043606918;890.688259109313;890.8663700444953;740.4409670698615;881.2113158722939;901.3555307954844;903.029243563169;904.8326059678915;653.5490511547017;658.1345530627258;658.4337469775988;658.4469046001382;658.5061204096927;14312.499062532865;14372.281385930663;14401.063930844566;14420.495282665057;14436.566902992927;13665.931670341584;13924.234167120805;14021.789673154808;14052.859471405258;14106;12404.689882752913;12563.685907852285;12673.683157921034;12719.618411447671;12807.231566106064;4164.597938553789;4166.500019997589;4203.91592168155;4209.179210054041;4214.515330736974;54406.18390724142;54564.454355456335;55894;55997;56605.43394566084;10552.577896884191;10819.621313253998;10963;11162.386068766296;11241.83137252942;18884.905575472036;18967.33614323492;19087.61824763497;19168.71246931297;19176.137073831713;8157.829101611284;8341.582920853933;8414.789630259293;8565.443246188977;8657.826843463095;4879.463259041502;4883.560479556786;4951.702897826142;4985.252212168204;5024.748762561857;3309.6855798699085;3382.30662714143;3390.983045084759;3391.6269210386836;3395.3209358128474;642.6465444005778;642.7139922734432;651.6806764685365;652.6051738698019;655.2366493035655;614.7663887722637;621.9253689557282;705.7071315404049;730.2478447199393;762.0208032677982;9188.264938805014;9486.95256523713;9613.423194608346;9641.228701703987;9664.323497355259;598.1745191635515;648.1703419622796;655.5214693273937;808.9191080891982;829.8713699376606;4797.5607317804515;4858.659893807399;4866.294387313819;4891.095147397743;4919.0899683558655;55813.72093139508;57462.425375745705;57654;66914.33085669178;68217.65891170512;54627.453725463034;55145.724271378385;56115.43884561184;57886.7105664469;58271;52745;52773;53142;54640;55215;9523.095305945924;9659.206586454868;9758.902410976083;9797.608095676092;9874.605015799287;33132.33735325232;33523.664763352055;33719.4942075874;33730.325393491505;35373.82313088521;42394.364084539375;45454.77272613616;46069.30896036629;46406.53593464157;47488.762556187;12503.312317822243;12693.619191424272;12802.615921522369;12943.417546210254;13324.000699947737;14375.85624143787;14453.205073721047;14461;14979.775303370241;15315.540533784004;13842.238676872466;13847.307634618028;13912;14440.277986100442;14568.198749068903;13618.795718064039;13626.52307169284;14197.787033194716;14241.857581424467;14264.857351426768;13106.737865242832;13158.276294803878;13264;13412.32938353098;14010.719785604435;11087.223894327642;11249.606263780728;11466.656000320003;11566.30602163873;11745.1191160665;11335.4470766532;11488.138389620644;11547.4803633835;11660.30038197711;11703.707407314885 04:16:00 INFO - PROCESS | 23925 | __end_tp_report 04:16:00 INFO - PROCESS | 23925 | __start_cc_report 04:16:00 INFO - PROCESS | 23925 | _x_x_mozilla_cycle_collect,876 04:16:00 INFO - PROCESS | 23925 | __end_cc_report 04:16:00 INFO - PROCESS | 23925 | __startTimestamp1462533360188__endTimestamp 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - PROCESS | 23925 | ------- Summary: start ------- 04:16:00 INFO - PROCESS | 23925 | Number of tests: 6 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - PROCESS | 23925 | [#0] dojo.html Cycles:165 Average:5297.37 Median:5499.53 stddev:596.51 (10.8%) stddev-sans-first:573.17 04:16:00 INFO - PROCESS | 23925 | Values: 3112.1 3143.5 3158.1 3179.5 3209.7 5185.0 5226.2 5234.5 5343.2 5352.9 5268.4 5273.6 5281.6 5350.7 5352.6 4742.8 4822.1 4866.9 4876.5 5002.2 4899.3 4968.0 4981.5 4981.7 4998.2 4632.4 4789.0 4809.9 4838.2 4843.2 4852.9 4857.9 4867.6 4873.3 4910.8 4658.2 4834.7 4853.1 4856.6 4890.4 5193.5 5252.9 5255.4 5313.9 5336.0 5715.9 5778.2 5782.0 5786.7 5792.4 5496.1 5665.6 5800.7 5848.8 5854.4 5306.5 5376.5 5424.1 5425.1 5431.4 5919.2 5960.3 5964.8 5968.9 5978.6 5397.4 5511.0 5552.7 5720.0 5723.7 5679.6 5682.5 5684.1 5693.2 5723.1 5626.5 5644.7 5667.5 5669.3 5674.4 5372.8 5573.5 5599.6 5623.7 5647.5 4333.6 4346.8 4346.8 4358.8 4377.5 3867.1 3889.2 3907.1 3939.2 3959.8 5120.8 5172.6 5291.9 5324.9 5376.5 5690.3 5707.7 5708.9 5717.9 5722.6 5398.3 5409.9 5411.7 5411.9 5454.4 4772.1 4886.7 4909.3 4916.3 4989.0 5920.3 5922.4 5930.9 5938.0 5951.2 5699.1 5713.2 5716.1 5718.7 5720.0 5638.5 5854.2 5931.5 5949.2 5980.8 5617.8 5642.4 5662.4 5665.5 5672.9 5433.1 5731.3 5731.5 5732.7 5743.5 5392.6 5525.7 5582.7 5589.1 5650.7 5613.3 5632.0 5632.4 5633.0 5634.1 5225.7 5518.7 5518.8 5534.3 5534.6 5532.9 5588.6 5603.3 5679.0 5682.6 5474.9 5499.5 5508.9 5518.4 5549.9 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - PROCESS | 23925 | [#1] ext.html Cycles:180 Average:57080.05 Median:41353.50 stddev:108002.77 (261.2%) stddev-sans-first:108222.60 04:16:00 INFO - PROCESS | 23925 | Values: 635.7 642.7 644.4 652.4 657.6 30556.7 33807.0 43936.0 44638.8 44798.8 44447.0 44957.0 44983.0 44993.3 45000.1 8753.6 8912.6 8928.1 8928.2 8931.0 8788.3 8895.0 8897.7 8901.9 8909.2 8685.2 8707.8 8712.5 8713.5 8720.6 8842.9 8876.8 8879.3 8885.5 8886.1 8782.8 8873.8 8875.5 8877.3 8881.2 41513.4 42262.0 42274.8 42281.8 42360.0 3609.4 3725.8 3778.9 3849.6 3885.5 31275.7 31450.0 31939.7 32131.7 32816.7 4318.7 4358.8 4409.6 4417.5 4435.9 326376.0 326688.0 327006.0 331512.0 332330.0 60382.4 61498.0 61599.4 61633.0 61659.7 56397.4 57780.0 57782.4 58046.3 61821.4 16529.5 16579.7 16703.9 16708.4 16733.7 11300.5 12773.6 12867.9 12881.4 12882.3 19173.7 19515.7 20179.7 20221.9 20359.9 6918.6 7045.4 7124.7 7337.5 7489.7 1020.8 1044.4 1057.3 1059.5 1234.7 32006.0 32327.0 32439.8 32516.2 32743.5 1148.2 1183.1 1195.3 1209.0 1249.1 16701.4 16785.5 16806.7 16819.5 16970.8 481164.0 485311.0 485411.0 485653.0 487275.0 57338.0 58573.0 58585.0 58600.0 58640.0 1415.9 1420.1 1431.1 1443.1 1460.7 30041.7 30398.0 31251.0 31476.8 31850.7 49213.0 49495.3 49898.3 49909.8 49915.5 394367.0 397795.0 398489.0 398802.0 399589.0 24955.0 27359.2 27942.0 27961.4 28117.9 46815.0 47015.8 47168.0 47445.8 48268.0 40479.0 40909.0 41078.6 41444.0 41914.4 39679.8 39716.4 40894.8 41143.4 41263.0 39658.2 41782.6 42347.4 42715.8 42988.6 34724.8 36499.6 36773.3 37404.8 37889.0 28676.0 28757.9 28960.7 29184.6 29413.4 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - PROCESS | 23925 | [#2] jquery.html Cycles:180 Average:28383.77 Median:22453.61 stddev:78428.25 (349.3%) stddev-sans-first:78620.13 04:16:00 INFO - PROCESS | 23925 | Values: 407.3 413.3 413.4 415.5 424.5 17367.7 19036.0 19166.5 19185.0 20202.8 17350.6 17682.1 17829.2 17855.8 17904.2 5634.3 5641.3 5747.2 5798.6 5823.9 5701.8 5751.1 5751.8 5753.6 5773.7 5536.6 5718.5 5746.6 5787.2 5797.0 5529.4 5726.7 5745.9 5761.2 5781.0 5075.1 5082.8 5089.4 5090.0 5115.1 22188.6 22250.6 22656.7 23159.7 23224.2 2224.2 2413.9 2472.8 2518.8 2586.7 10155.3 10596.5 11496.4 14089.9 14740.6 1968.5 2023.9 2055.0 2056.9 2070.0 80473.6 84014.0 84262.2 84484.6 84643.0 10894.9 10940.3 11026.9 11145.9 11351.4 15256.6 15273.8 15426.7 15437.0 15444.2 8118.7 8236.1 8273.3 8351.7 8421.3 7955.2 8095.4 8104.7 8389.9 8415.7 4500.2 4684.5 4728.0 4744.2 4760.1 1968.5 1978.9 1983.6 2000.7 2044.7 946.4 1068.7 1088.8 1096.3 1115.4 18390.7 18493.3 18720.5 18989.0 19425.3 1019.3 1026.9 1027.3 1029.6 1047.2 10404.6 10690.1 10823.9 10835.3 10854.4 468819.0 471053.0 471592.0 475004.0 488005.0 89186.0 91548.0 92676.5 92788.5 93386.0 1025.1 1043.6 1047.6 1057.4 1060.7 16260.7 16447.3 16684.3 16913.8 17218.1 37934.4 38637.8 38792.8 39177.6 40042.8 51045.5 51615.5 54556.7 59781.4 61037.4 7996.4 8170.4 8376.5 8495.9 8746.0 11456.5 12400.0 12496.4 12813.5 12962.2 11201.1 11209.7 11413.4 11474.8 11584.5 5131.9 10593.9 11182.3 11224.8 11352.8 10430.5 11161.9 11471.8 11519.9 11886.5 8348.4 8442.2 8579.7 8658.0 8701.7 11359.6 11405.1 11463.7 11646.9 11794.1 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - PROCESS | 23925 | [#3] mootools.html Cycles:180 Average:5790.70 Median:4659.71 stddev:3327.90 (71.4%) stddev-sans-first:3320.35 04:16:00 INFO - PROCESS | 23925 | Values: 1330.2 1549.4 1572.5 1753.3 1872.1 8273.9 8597.3 8642.9 8841.9 8863.2 8642.6 8824.7 8843.2 8855.4 8862.7 1907.5 1952.5 2183.2 2232.6 2265.6 2246.0 2276.4 2276.6 2280.9 2280.9 2203.5 2223.7 2234.2 2234.9 2240.9 1823.2 1870.9 1876.3 2071.7 2087.7 2155.8 2194.0 2197.0 2200.4 2201.6 8828.5 8837.6 8894.2 8894.7 8915.7 5074.7 5188.5 5229.6 5233.3 5235.1 3361.0 3421.4 3518.7 3528.1 3553.3 1124.7 1141.1 2134.7 2166.8 2185.2 11931.2 12405.2 12578.9 12592.2 12598.2 4533.5 4568.2 4609.1 4643.9 4675.6 9742.3 9748.9 9752.1 9763.2 9766.6 5218.9 5221.3 5227.7 5247.0 5256.4 4123.4 4611.0 4771.6 4779.8 4826.6 3773.3 3781.4 3856.4 3900.2 3929.0 1097.2 1145.6 1148.7 1149.9 1171.1 987.5 990.6 991.3 996.9 1004.5 5976.9 6091.4 6108.8 6145.9 6220.9 434.9 443.8 444.4 445.3 448.0 4024.8 4177.5 4231.8 4272.6 4296.5 10556.7 10984.0 11012.3 11031.2 11082.4 10321.5 10765.1 10911.7 10995.6 11236.7 8297.5 8334.1 8338.9 8378.8 8405.7 5993.8 6096.4 6109.9 6131.1 6238.4 10093.1 10299.9 10306.0 10374.5 10419.7 9959.9 10247.8 10558.4 10671.8 10674.4 6943.1 7591.9 7785.5 7962.4 8076.1 8406.9 8450.0 8485.1 8495.2 8536.5 7486.2 7603.7 7668.6 7715.7 7736.5 7522.8 7629.5 7656.5 7791.2 7808.5 7045.5 7101.9 7120.2 7122.8 7123.8 5043.6 5189.4 5259.4 5321.0 5332.8 5097.2 5143.4 5144.2 5296.3 5416.1 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - PROCESS | 23925 | [#4] prototype.html Cycles:180 Average:4547.82 Median:5159.75 stddev:1318.97 (25.6%) stddev-sans-first:1284.25 04:16:00 INFO - PROCESS | 23925 | Values: 337.0 343.9 347.6 354.0 354.6 5204.0 5214.8 5229.5 5245.3 5265.7 5140.0 5149.5 5151.4 5168.1 5187.7 3840.9 3921.9 4066.8 4087.7 4106.0 4050.3 4053.8 4056.4 4070.2 4081.4 3801.4 4021.1 4022.2 4032.6 4036.3 3935.4 3976.4 4071.7 4077.8 4080.6 3590.0 3608.7 3614.7 3619.3 3621.5 5019.6 5023.9 5039.5 5044.4 5053.3 4508.1 4635.9 4640.3 4650.7 4652.7 5363.2 5373.0 5380.8 5407.4 5433.9 3947.5 3956.5 3966.8 3974.3 3977.1 5405.4 5622.3 5622.9 5629.2 5643.8 4006.7 4027.7 4029.5 4040.9 4041.7 4038.7 4048.2 4081.7 4091.1 4131.4 4468.4 4652.1 4657.5 4688.6 4703.2 5369.5 5399.3 5454.3 5455.8 5465.2 1377.0 1377.8 1387.4 1387.4 1388.4 914.7 976.2 994.2 1001.5 1005.0 5030.5 5063.4 5084.5 5100.5 5117.2 5316.4 5349.7 5398.6 5409.6 5409.9 4784.3 5037.0 5051.2 5073.8 5105.3 2830.2 2838.6 2854.9 2869.9 2876.7 5590.4 5628.2 5629.0 5643.5 5666.6 5275.5 5432.8 5458.7 5464.7 5510.7 5449.7 5450.5 5476.5 5562.7 5590.9 5260.1 5355.3 5362.9 5368.7 5404.4 5511.0 5521.3 5541.2 5563.7 5566.9 5782.4 5799.9 5822.6 5840.4 5857.5 3873.2 3956.8 3968.2 3971.8 3987.3 5567.7 5570.7 5584.4 5590.7 5605.8 5428.4 5432.2 5470.0 5470.8 5489.8 5261.7 5432.5 5435.4 5460.0 5482.4 5144.7 5380.7 5389.5 5396.6 5413.9 5311.9 5459.5 5471.5 5484.0 5543.8 5348.9 5353.9 5367.6 5368.2 5369.2 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - PROCESS | 23925 | [#5] yui.html Cycles:180 Average:15266.26 Median:4828.11 stddev:17343.11 (359.2%) stddev-sans-first:17357.39 04:16:00 INFO - PROCESS | 23925 | Values: 726.9 790.8 798.3 801.0 809.9 14266.1 14405.9 14587.9 14686.3 14703.4 13765.7 13821.1 13821.6 13830.7 13831.4 705.0 824.9 828.2 855.2 858.5 828.0 837.0 838.9 839.8 840.0 888.5 889.9 889.9 890.7 890.9 740.4 881.2 901.4 903.0 904.8 653.5 658.1 658.4 658.4 658.5 14312.5 14372.3 14401.1 14420.5 14436.6 13665.9 13924.2 14021.8 14052.9 14106.0 12404.7 12563.7 12673.7 12719.6 12807.2 4164.6 4166.5 4203.9 4209.2 4214.5 54406.2 54564.5 55894.0 55997.0 56605.4 10552.6 10819.6 10963.0 11162.4 11241.8 18884.9 18967.3 19087.6 19168.7 19176.1 8157.8 8341.6 8414.8 8565.4 8657.8 4879.5 4883.6 4951.7 4985.3 5024.7 3309.7 3382.3 3391.0 3391.6 3395.3 642.6 642.7 651.7 652.6 655.2 614.8 621.9 705.7 730.2 762.0 9188.3 9487.0 9613.4 9641.2 9664.3 598.2 648.2 655.5 808.9 829.9 4797.6 4858.7 4866.3 4891.1 4919.1 55813.7 57462.4 57654.0 66914.3 68217.7 54627.5 55145.7 56115.4 57886.7 58271.0 52745.0 52773.0 53142.0 54640.0 55215.0 9523.1 9659.2 9758.9 9797.6 9874.6 33132.3 33523.7 33719.5 33730.3 35373.8 42394.4 45454.8 46069.3 46406.5 47488.8 12503.3 12693.6 12802.6 12943.4 13324.0 14375.9 14453.2 14461.0 14979.8 15315.5 13842.2 13847.3 13912.0 14440.3 14568.2 13618.8 13626.5 14197.8 14241.9 14264.9 13106.7 13158.3 13264.0 13412.3 14010.7 11087.2 11249.6 11466.7 11566.3 11745.1 11335.4 11488.1 11547.5 11660.3 11703.7 04:16:00 INFO - PROCESS | 23925 | -------- Summary: end -------- 04:16:00 INFO - PROCESS | 23925 | 04:16:00 INFO - TEST-INFO | 23925: exit 0 04:16:00 INFO - TEST-OK | dromaeo_css | took 1112542ms 04:16:00 INFO - TEST-START | kraken 04:16:00 INFO - operating with platform_type : linux_ 04:16:00 INFO - Initialising browser for kraken test... 04:16:00 INFO - TEST-INFO | started process 24110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3TW3oJ/profile http://localhost:50377/getInfo.html) 04:16:05 INFO - PROCESS | 24110 | __metrics Screen width/height:1600/1200 04:16:05 INFO - PROCESS | 24110 | colorDepth:24 04:16:05 INFO - PROCESS | 24110 | Browser inner width/height: 1024/697 04:16:05 INFO - PROCESS | 24110 | __metrics 04:16:05 ERROR - PROCESS | 24110 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:16:06 INFO - TEST-INFO | 24110: exit 0 04:16:06 INFO - Browser initialized. 04:16:06 INFO - Running cycle 1/1 for kraken test... 04:16:06 INFO - TEST-INFO | started process 24193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3TW3oJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:18 INFO - PROCESS | 24193 | RSS: Main: 151863296 04:16:18 INFO - PROCESS | 24193 | 04:16:21 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50377/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:21 INFO - PROCESS | 24193 | RSS: Main: 207949824 04:16:21 INFO - PROCESS | 24193 | 04:16:24 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50377/tests/kraken/driver.html?testName=audio-dft) 04:16:25 INFO - PROCESS | 24193 | RSS: Main: 196898816 04:16:25 INFO - PROCESS | 24193 | 04:16:28 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50377/tests/kraken/driver.html?testName=audio-fft) 04:16:28 INFO - PROCESS | 24193 | RSS: Main: 264376320 04:16:28 INFO - PROCESS | 24193 | 04:16:30 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50377/tests/kraken/driver.html?testName=audio-oscillator) 04:16:31 INFO - PROCESS | 24193 | RSS: Main: 173539328 04:16:31 INFO - PROCESS | 24193 | 04:16:33 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:16:34 INFO - PROCESS | 24193 | RSS: Main: 178130944 04:16:34 INFO - PROCESS | 24193 | 04:16:37 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50377/tests/kraken/driver.html?testName=imaging-darkroom) 04:16:37 INFO - PROCESS | 24193 | RSS: Main: 214167552 04:16:37 INFO - PROCESS | 24193 | 04:16:41 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50377/tests/kraken/driver.html?testName=imaging-desaturate) 04:16:41 INFO - PROCESS | 24193 | RSS: Main: 214798336 04:16:41 INFO - PROCESS | 24193 | 04:16:44 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50377/tests/kraken/driver.html?testName=json-parse-financial) 04:16:45 INFO - PROCESS | 24193 | RSS: Main: 215449600 04:16:45 INFO - PROCESS | 24193 | 04:16:46 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:47 INFO - PROCESS | 24193 | RSS: Main: 201461760 04:16:47 INFO - PROCESS | 24193 | 04:16:49 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:49 INFO - PROCESS | 24193 | RSS: Main: 205946880 04:16:49 INFO - PROCESS | 24193 | 04:16:51 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:52 INFO - PROCESS | 24193 | RSS: Main: 215375872 04:16:52 INFO - PROCESS | 24193 | 04:16:55 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:55 INFO - PROCESS | 24193 | RSS: Main: 221937664 04:16:55 INFO - PROCESS | 24193 | 04:16:58 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:59 INFO - PROCESS | 24193 | RSS: Main: 218001408 04:16:59 INFO - PROCESS | 24193 | 04:17:00 INFO - PROCESS | 24193 | Cycle 1(1): loaded http://localhost:50377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50377/tests/kraken/driver.html?testName=ai-astar) 04:17:01 INFO - PROCESS | 24193 | RSS: Main: 263868416 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | __start_tp_report 04:17:01 INFO - PROCESS | 24193 | _x_x_mozilla_page_load 04:17:01 INFO - PROCESS | 24193 | _x_x_mozilla_page_load_details 04:17:01 INFO - PROCESS | 24193 | |i|pagename|runs| 04:17:01 INFO - PROCESS | 24193 | |0;ai-astar;111;105;112;111;110;110;110;110;111;110 04:17:01 INFO - PROCESS | 24193 | |1;audio-beat-detection;158;124;155;178;125;161;154;136;174;141 04:17:01 INFO - PROCESS | 24193 | |2;audio-dft;161;160;162;161;161;160;160;159;160;161 04:17:01 INFO - PROCESS | 24193 | |3;audio-fft;75;77;75;115;75;75;76;74;133;75 04:17:01 INFO - PROCESS | 24193 | |4;audio-oscillator;91;91;122;91;92;91;119;92;92;119 04:17:01 INFO - PROCESS | 24193 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 04:17:01 INFO - PROCESS | 24193 | |6;imaging-darkroom;146;146;146;146;146;147;147;147;147;146 04:17:01 INFO - PROCESS | 24193 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 04:17:01 INFO - PROCESS | 24193 | |8;json-parse-financial;60;61;62;62;62;60;60;78;59;58 04:17:01 INFO - PROCESS | 24193 | |9;json-stringify-tinderbox;59;59;57;59;59;59;59;59;58;59 04:17:01 INFO - PROCESS | 24193 | |10;stanford-crypto-aes;78;79;78;78;85;81;79;79;79;79 04:17:01 INFO - PROCESS | 24193 | |11;stanford-crypto-ccm;123;138;136;129;124;122;124;130;216;129 04:17:01 INFO - PROCESS | 24193 | |12;stanford-crypto-pbkdf2;173;170;171;167;167;167;168;174;169;166 04:17:01 INFO - PROCESS | 24193 | |13;stanford-crypto-sha256-iterative;67;64;65;64;64;65;65;65;66;65 04:17:01 INFO - PROCESS | 24193 | __end_tp_report 04:17:01 INFO - PROCESS | 24193 | __start_cc_report 04:17:01 INFO - PROCESS | 24193 | _x_x_mozilla_cycle_collect,1556 04:17:01 INFO - PROCESS | 24193 | __end_cc_report 04:17:01 INFO - PROCESS | 24193 | __startTimestamp1462533421097__endTimestamp 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | ------- Summary: start ------- 04:17:01 INFO - PROCESS | 24193 | Number of tests: 14 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.89 (1.7%) stddev-sans-first:1.96 04:17:01 INFO - PROCESS | 24193 | Values: 111.0 105.0 112.0 111.0 110.0 110.0 110.0 110.0 111.0 110.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:156.50 stddev:18.74 (12.0%) stddev-sans-first:19.68 04:17:01 INFO - PROCESS | 24193 | Values: 158.0 124.0 155.0 178.0 125.0 161.0 154.0 136.0 174.0 141.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 04:17:01 INFO - PROCESS | 24193 | Values: 161.0 160.0 162.0 161.0 161.0 160.0 160.0 159.0 160.0 161.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#3] audio-fft Cycles:10 Average:85.00 Median:75.00 stddev:21.00 (28.0%) stddev-sans-first:21.96 04:17:01 INFO - PROCESS | 24193 | Values: 75.0 77.0 75.0 115.0 75.0 75.0 76.0 74.0 133.0 75.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:91.00 stddev:13.83 (15.2%) stddev-sans-first:14.28 04:17:01 INFO - PROCESS | 24193 | Values: 91.0 91.0 122.0 91.0 92.0 91.0 119.0 92.0 92.0 119.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:17:01 INFO - PROCESS | 24193 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:17:01 INFO - PROCESS | 24193 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:17:01 INFO - PROCESS | 24193 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:61.50 stddev:5.71 (9.3%) stddev-sans-first:6.00 04:17:01 INFO - PROCESS | 24193 | Values: 60.0 61.0 62.0 62.0 62.0 60.0 60.0 78.0 59.0 58.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 04:17:01 INFO - PROCESS | 24193 | Values: 59.0 59.0 57.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.12 (2.7%) stddev-sans-first:2.18 04:17:01 INFO - PROCESS | 24193 | Values: 78.0 79.0 78.0 78.0 85.0 81.0 79.0 79.0 79.0 79.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:129.50 stddev:28.24 (21.8%) stddev-sans-first:29.49 04:17:01 INFO - PROCESS | 24193 | Values: 123.0 138.0 136.0 129.0 124.0 122.0 124.0 130.0 216.0 129.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.50 stddev:2.74 (1.6%) stddev-sans-first:2.54 04:17:01 INFO - PROCESS | 24193 | Values: 173.0 170.0 171.0 167.0 167.0 167.0 168.0 174.0 169.0 166.0 04:17:01 INFO - PROCESS | 24193 | 04:17:01 INFO - PROCESS | 24193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:0.67 04:17:01 INFO - PROCESS | 24193 | Values: 67.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 66.0 65.0 04:17:01 INFO - PROCESS | 24193 | -------- Summary: end -------- 04:17:01 INFO - PROCESS | 24193 | 04:17:02 INFO - TEST-INFO | 24193: exit 0 04:17:02 INFO - TEST-OK | kraken | took 61087ms 04:17:02 INFO - SUITE-END | took 1173s 04:17:02 INFO - Completed test suite (00:19:33) 04:17:02 INFO - javascript benchmark 04:17:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.1286039908828, 3143.497040473523, 3158.0841555948778, 3179.523071539267, 3209.6790320967907, 5184.974075129629, 5226.189940559215, 5234.528892399683, 5343.225232341313, 5352.892942141155, 5268.446813084628, 5273.5781137509, 5281.603879709018, 5350.705711185883, 5352.57179425646, 4742.7865746041425, 4822.107910036637, 4866.878328041792, 4876.463589005207, 5002.249662550628, 4899.265110233458, 4967.950320496803, 4981.476944920785, 4981.651284410093, 4998.200287953928, 4632.351470794091, 4788.97605511972, 4809.879753006167, 4838.153323168449, 4843.15244832153, 4852.927206091911, 4857.878553036167, 4867.586255168315, 4873.269009648581, 4910.8281210157475, 4658.1848176568965, 4834.709917404932, 4853.126437241295, 4856.587190088847, 4890.437599676047, 5193.506616871391, 5252.947470525284, 5255.421903590602, 5313.8937221255355, 5336.039512887679, 5715.914261286042, 5778.219940308047, 5781.959247335478, 5786.68173250471, 5792.4497172768515, 5496.120620700709, 5665.631733937281, 5800.680962547058, 5848.766049358021, 5854.443827836349, 5306.52241298285, 5376.462353764592, 5424.105022671254, 5425.050616142199, 5431.402545719968, 5919.230500034968, 5960.314563825129, 5964.821055368346, 5968.940310596925, 5978.55160862937, 5397.406285308692, 5511.0, 5552.7223638817895, 5719.971400142973, 5723.685197314105, 5679.630823996427, 5682.54539636828, 5684.062129748545, 5693.202951586781, 5723.084306510938, 5626.549876009909, 5644.6613203207935, 5667.546596272288, 5669.262995810518, 5674.375818659944, 5372.838814835562, 5573.470520300565, 5599.608027438122, 5623.718814059363, 5647.463490968352, 4333.631641310524, 4346.7609281489185, 4346.8043938022865, 4358.782060896942, 4377.474703035656, 3867.106728169245, 3889.202713443737, 3907.1208977980295, 3939.153082087365, 3959.802009899551, 5120.7951681933055, 5172.637915345965, 5291.920621190685, 5324.893502129936, 5376.46235376467, 5690.317161940594, 5707.74315155819, 5708.857278567986, 5717.857053573611, 5722.570807189478, 5398.325209348832, 5409.918851217235, 5411.729413529308, 5411.864703382368, 5454.427285135083, 4772.093302272627, 4886.7067975920845, 4909.337239472697, 4916.336294600254, 4989.027139707722, 5920.319163296276, 5922.437368449991, 5930.940690593039, 5938.0, 5951.226340575698, 5699.116636921284, 5713.200151978809, 5716.114002329646, 5718.656880587178, 5719.999000174953, 5638.548916086621, 5854.180414742024, 5931.495822854933, 5949.167116603766, 5980.820575382745, 5617.831465056055, 5642.379338272704, 5662.405447428126, 5665.49010589049, 5672.943270567242, 5433.130699088127, 5731.254936858182, 5731.5128214100605, 5732.656040637575, 5743.4543718346695, 5392.649477783932, 5525.696086715108, 5582.748776304995, 5589.077802162597, 5650.660960342392, 5613.298337707786, 5631.971840140773, 5632.352279487911, 5633.0, 5634.070378387521, 5225.738713064407, 5518.724063796713, 5518.779248830162, 5534.308211473566, 5534.584906132137, 5532.889342213214, 5588.636738611977, 5603.271574695264, 5679.0, 5682.602217844711, 5474.945250547444, 5499.5325397340075, 5508.862278443071, 5518.448155184449, 5549.861253468695], "value": 5258.219489118439, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.7043974551832, 642.6690254518923, 644.4007073421716, 652.3834975947725, 657.6120089147402, 30556.69443305569, 33807.0, 43936.0, 44638.77680611592, 44798.77600612, 44447.0, 44957.0, 44983.0, 44993.325100123526, 45000.09999800002, 8753.562321883895, 8912.643494260254, 8928.107189281085, 8928.151825576593, 8931.0, 8788.296936245086, 8894.955525222396, 8897.68858089967, 8901.910980890205, 8909.198172164504, 8685.218330350268, 8707.782305442382, 8712.520811355405, 8713.477191368538, 8720.563971801415, 8842.911570884273, 8876.822463550758, 8879.289656827503, 8885.46687198767, 8886.111388861127, 8782.780430489289, 8873.757673925655, 8875.511846848422, 8877.33419993503, 8881.245094167003, 41513.37729934054, 42262.0, 42274.78862605698, 42281.78859105716, 42360.0, 3609.404448266033, 3725.832337544817, 3778.9055273618105, 3849.5957924418094, 3885.4560361549406, 31275.687243127733, 31450.0, 31939.6806031939, 32131.678683213104, 32816.6718332816, 4318.654507639413, 4358.782060896942, 4409.603135717801, 4417.469903611587, 4435.866923992253, 326376.0, 326688.0, 327006.0, 331511.9999999976, 332330.0, 60382.39617603856, 61498.0, 61599.38400616026, 61633.0, 61659.691701541204, 56397.43602563922, 57780.0, 57782.422175777705, 58046.32467266234, 61821.381786182465, 16529.504114876574, 16579.6684066318, 16703.91648041752, 16708.41520546775, 16733.665326693397, 11300.547978080785, 12773.61679149627, 12867.935660321638, 12881.420336084899, 12882.291473969022, 19173.712394314098, 19515.74187508103, 20179.697304540445, 20221.898890505454, 20359.898200508902, 6918.5502942309595, 7045.365917067488, 7124.684477544819, 7337.486375953632, 7489.662965166581, 1020.831562792131, 1044.4307852220559, 1057.3285963413289, 1059.5338051257422, 1234.7407044520571, 32006.0, 32327.0, 32439.837800811318, 32516.187095322806, 32743.50884736731, 1148.1847887999447, 1183.0653783511102, 1195.2529668956902, 1208.957686480969, 1249.0694432647736, 16701.374427321978, 16785.496435106965, 16806.663866722596, 16819.495415137564, 16970.830291697173, 481164.0, 485311.0, 485411.0, 485653.0, 487275.0, 57338.0, 58573.0, 58585.0, 58600.0, 58640.0, 1415.929203539819, 1420.0911416693325, 1431.0698046270008, 1443.0620096937075, 1460.7224627320988, 30041.699583004764, 30398.0, 31251.0, 31476.842615786776, 31850.681493184773, 49213.0, 49495.25757113574, 49898.251526226406, 49909.75045124751, 49915.50084499254, 394367.0, 397795.0, 398489.0, 398802.0, 399589.0, 24955.0, 27359.179224623294, 27942.0, 27961.44077118487, 28117.859410702815, 46815.0, 47015.764921176546, 47168.0, 47445.762771185924, 48268.0, 40479.0, 40909.0, 41078.58921410867, 41444.0, 41914.37128443015, 39679.80160099296, 39716.404253936795, 40894.79552602337, 41143.38284925788, 41263.0, 39658.20683586255, 41782.58217417787, 42347.364789527564, 42715.78642106769, 42988.570114298454, 34724.82637586796, 36499.635003650685, 36773.26453470969, 37404.81297593604, 37889.0, 28676.0, 28757.85621071881, 28960.710392895802, 29184.56223156612, 29413.411731765675], "value": 20098.764587183563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.29944495467794, 413.2520138549228, 413.3840577539467, 415.4619767401215, 424.53089336283404, 17367.65264694707, 19036.0, 19166.520836979063, 19184.99999999998, 20202.797972020275, 17350.56623584411, 17682.11589420527, 17829.197686104126, 17855.821441785578, 17904.194311255993, 5634.32388113427, 5641.266635337401, 5747.195392645033, 5798.594098413113, 5823.883522329551, 5701.800436984707, 5751.05107657236, 5751.7986870459545, 5753.568482363839, 5773.740181691813, 5536.640118392312, 5718.542516598683, 5746.569007324447, 5787.189793428924, 5797.0, 5529.4470552944385, 5726.68503232322, 5745.885082298372, 5761.222234998285, 5781.046127388997, 5075.111855425286, 5082.79668813247, 5089.389273287229, 5089.974550127263, 5115.104856650071, 22188.55622887533, 22250.554988900294, 22656.660150097763, 23159.652605210937, 23224.187153449548, 2224.2104053061253, 2413.9396515087087, 2472.7898128659085, 2518.8236823422367, 2586.6895972483235, 10155.28912976092, 10596.523156457977, 11496.42517874103, 14089.929550352284, 14740.631484212874, 1968.4685135013467, 2023.9190432382686, 2055.0444043519688, 2056.8663036902703, 2069.968950465744, 80473.59763201205, 84014.0, 84262.15737842604, 84484.57757711296, 84643.0, 10894.894954937805, 10940.288881222854, 11026.944865275622, 11145.944270278596, 11351.37567433799, 15256.618584535254, 15273.770893436607, 15426.691466170838, 15437.0, 15444.227788610524, 8118.715844945398, 8236.135205803424, 8273.296769774517, 8351.707690230813, 8421.284190843724, 7955.164707705608, 8095.392845536609, 8104.675812967534, 8389.874151887727, 8415.74752757406, 4500.189965806121, 4684.508126646721, 4728.0, 4744.217204161275, 4760.119377915097, 1968.507873031742, 1978.9010549472468, 1983.5537004173946, 2000.689893066577, 2044.6830741235133, 946.3801210207325, 1068.7488440216543, 1088.8312311591558, 1096.2545469080942, 1115.369816053927, 18390.724139137925, 18493.260269589067, 18720.53198670044, 18989.0, 19425.320113795948, 1019.3425240719695, 1026.8973102689672, 1027.3322340478599, 1029.5572903651353, 1047.1936608811172, 10404.635837745642, 10690.09134223584, 10823.891761082446, 10835.349879007284, 10854.403007834488, 468819.0, 471053.0, 471592.0, 475004.0, 488005.0, 89186.0, 91548.0, 92676.53661731648, 92788.53605731929, 93386.0, 1025.0979138358198, 1043.6242952537082, 1047.5547892145808, 1057.39728354837, 1060.7030031591166, 16260.674786503967, 16447.342106315613, 16684.332626694795, 16913.830861691225, 17218.05300708473, 37934.430983534716, 38637.80681096577, 38792.80603596964, 39177.6082239174, 40042.79978600088, 51045.48954510407, 51615.48384516107, 54556.727216363666, 59781.40218597758, 61037.389626104945, 7996.440249182734, 8170.387220958571, 8376.455530390505, 8495.872561911452, 8746.0, 11456.484458199568, 12400.0, 12496.375181240719, 12813.487460501476, 12962.22226666403, 11201.103911687209, 11209.663710088711, 11413.372264525531, 11474.827877581676, 11584.47869845842, 5131.897362052663, 10593.8876417975, 11182.273152245078, 11224.831627525757, 11352.772944541228, 10430.53062612169, 11161.944190278997, 11471.827922581335, 11519.88480115188, 11886.524539018688, 8348.37387195975, 8442.197991190827, 8579.742607721779, 8658.0, 8701.651933922572, 11359.602413915472, 11405.087592992706, 11463.656090317303, 11646.94176529112, 11794.115441341763], "value": 9176.295458249811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.241762195549, 1549.3647604482157, 1572.457502161754, 1753.2986805277887, 1872.1107473949867, 8273.917260827397, 8597.3122150228, 8642.870356944652, 8841.867371989409, 8863.157999990006, 8642.611082501287, 8824.691135810248, 8843.248323892476, 8855.380123391365, 8862.689805856797, 1907.5040489472767, 1952.453313072342, 2183.192218879009, 2232.5758105959817, 2265.6035193841094, 2245.9887700561476, 2276.4081338851934, 2276.6129757941108, 2280.851744636602, 2280.908763649452, 2203.46015226269, 2223.655333423322, 2234.240358278185, 2234.8882555872224, 2240.8767517786514, 1823.1522342110916, 1870.8877467352002, 1876.2682553804027, 2071.7203177571137, 2087.65553683642, 2155.795199456049, 2193.9561208775735, 2197.04428573571, 2200.3508964855405, 2201.559688062394, 8828.470291782514, 8837.646494140226, 8894.155055269739, 8894.733158005205, 8915.732528024104, 5074.720890351029, 5188.481151884819, 5229.555487783543, 5233.345831771028, 5235.136202526579, 3361.0, 3421.4012547804036, 3518.736094792901, 3528.1356067763304, 3553.342631613134, 1124.7075760302298, 1141.1156353825768, 2134.7224860768156, 2166.8483206175574, 2185.2024011235944, 11931.164818462712, 12405.193662411913, 12578.937105314415, 12592.244465332018, 12598.181118227287, 4533.52397998212, 4568.223402021665, 4609.101225261042, 4643.86068417948, 4675.555822196886, 9742.269329800152, 9748.853767193497, 9752.122308992082, 9763.170130538841, 9766.560504777302, 5218.921716174261, 5221.321228240305, 5227.660202086929, 5247.02929957959, 5256.421793602701, 4123.402106694512, 4610.976945115253, 4771.618270538418, 4779.808807647724, 4826.613870890391, 3773.3019391412677, 3781.4138808484727, 3856.421536769451, 3900.2004589059175, 3928.9607103929166, 1097.1825989637612, 1145.6276710069094, 1148.6726283009302, 1149.9022583080364, 1171.1392126786805, 987.4667679453158, 990.5599635473944, 991.3209451525728, 996.8704068471052, 1004.5178314408978, 5976.850578735566, 6091.390860913873, 6108.816735497942, 6145.907811382833, 6220.906686399708, 434.8673654535334, 443.80250788398854, 444.4155934945536, 445.31421610719775, 447.985313265454, 4024.7987600619854, 4177.4778152730905, 4231.767252801125, 4272.594103560157, 4296.548862369406, 10556.683299501028, 10984.0, 11012.339259644446, 11031.172662050378, 11082.390468524147, 10321.483925803679, 10765.13878889687, 10911.672649820519, 10995.560177592966, 11236.719082023015, 8297.460665056873, 8334.124916883882, 8338.874916876252, 8378.832423351621, 8405.705800297083, 5993.820185394445, 6096.390360963868, 6109.938900611115, 6131.080337949344, 6238.376162383725, 10093.091621754078, 10299.948500257451, 10306.0, 10374.481275936323, 10419.739506512095, 9959.900400996186, 10247.795044099226, 10558.419286939292, 10671.786564268516, 10674.412907290174, 6943.097397338313, 7591.924080759342, 7785.455018148676, 7962.442629015914, 8076.111627721063, 8406.87389689143, 8450.0, 8485.109063548238, 8495.150484951455, 8536.530490823065, 7486.176520582841, 7603.695852165852, 7668.6165691716305, 7715.652795624323, 7736.497127686683, 7522.811929701801, 7629.54222746637, 7656.540607563564, 7791.181925897699, 7808.453408261595, 7045.542039767399, 7101.857962840818, 7120.181179164255, 7122.821929451805, 7123.7506687265695, 5043.62172837046, 5189.4032186299055, 5259.421463639073, 5320.973395133, 5332.760025798771, 5097.209932460474, 5143.434222235626, 5144.202648589475, 5296.258523806593, 5416.052190866504], "value": 4555.072926555329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.9915752106197, 343.92605589798205, 347.5533938888529, 354.01760115678974, 354.5674277381595, 5204.0, 5214.817481388152, 5229.450907654698, 5245.291885595443, 5265.657732247406, 5140.0, 5149.459306772782, 5151.407588127367, 5168.095583272921, 5187.714675692835, 3840.94509437451, 3921.9215615687667, 4066.8169932353117, 4087.734297270668, 4106.0, 4050.2911990401562, 4053.7973101344814, 4056.391541268804, 4070.1859628074358, 4081.387791831234, 3801.448789925473, 4021.055052062763, 4022.215667944737, 4032.6370626643597, 4036.3138266494766, 3935.3900145477496, 3976.403539469074, 4071.7149799514045, 4077.7553346799286, 4080.5924504542168, 3589.964100358989, 3608.747387682863, 3614.6927511161584, 3619.2761447710564, 3621.511096002059, 5019.623528235397, 5023.874403139914, 5039.488153553956, 5044.369453818273, 5053.267276244961, 4508.053308805155, 4635.884102897421, 4640.327152562893, 4650.7442090685, 4652.74409907455, 5363.168708850135, 5372.973135134299, 5380.757865896044, 5407.351117865842, 5433.891322173535, 3947.5262968443685, 3956.5252169739815, 3966.8214930327918, 3974.2647610192207, 3977.125032492847, 5405.4324295949145, 5622.297212848394, 5622.859428514279, 5629.240052592889, 5643.802466913638, 4006.7395619284653, 4027.718059735849, 4029.476168098187, 4040.878773636796, 4041.6766658667234, 4038.7374820636564, 4048.2105989332385, 4081.69387295954, 4091.1408604192857, 4131.380292956021, 4468.419105516262, 4652.092841895866, 4657.4876763555985, 4688.578027977498, 4703.247480403119, 5369.543588794996, 5399.325084364455, 5454.3454785426, 5455.8090466834265, 5465.207544905967, 1376.951806686781, 1377.8415482219673, 1387.361813565751, 1387.4172847404116, 1388.3752311459682, 914.7301546043933, 976.2141476111798, 994.2096033653119, 1001.5342865567401, 1005.0301459092011, 5030.496950305013, 5063.443021267658, 5084.51697088776, 5100.464451232641, 5117.155669314521, 5316.388615309289, 5349.652272602269, 5398.6220964532895, 5409.648372855751, 5409.945900541023, 4784.330193772875, 5036.974815125975, 5051.217061355495, 5073.822416215415, 5105.310783044316, 2830.249983754307, 2838.6451693538306, 2854.915132249732, 2869.9282517937218, 2876.7123287671484, 5590.413006634326, 5628.212050312959, 5628.97185514078, 5643.529229523813, 5666.631668941505, 5275.525202731773, 5432.782688692487, 5458.727063646802, 5464.726763661801, 5510.669359838343, 5449.6730196188355, 5450.4549545045975, 5476.452354764491, 5562.749676264659, 5590.86022849432, 5260.08065523638, 5355.27703760003, 5362.865928351823, 5368.711509237833, 5404.432534583812, 5510.972445137749, 5521.266972848305, 5541.224228608079, 5563.693996830213, 5566.888662226814, 5782.421757824184, 5799.884002320015, 5822.573469499999, 5840.415958404125, 5857.531397488276, 3873.1672690371706, 3956.84172633103, 3968.214303563466, 3971.8411263550292, 3987.342088555356, 5567.693776842312, 5570.749316280858, 5584.441555844383, 5590.664560126405, 5605.775768969359, 5428.430014848384, 5432.158015507603, 5470.0, 5470.835874923759, 5489.835304940858, 5261.736913154404, 5432.5110740032005, 5435.374931882726, 5460.044492213926, 5482.369527504228, 5144.717040562656, 5380.650257733391, 5389.487998640123, 5396.64921780083, 5413.891722165614, 5311.920321195108, 5459.543205557436, 5471.452854714656, 5483.972580137074, 5543.778248870161, 5348.9465105348445, 5353.946460535345, 5367.624266301322, 5368.22160786676, 5369.19462080691], "value": 4137.316784994076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9164046134696, 790.8457850719109, 798.2815466080528, 800.9839803203936, 809.9352051835854, 14266.144031358126, 14405.927970360133, 14587.854121458782, 14686.265686715662, 14703.411863525445, 13765.655858603515, 13821.101628394148, 13821.585352439417, 13830.723385532308, 13831.446742130303, 705.048184950318, 824.9051359093706, 828.200786241277, 855.2260204514924, 858.5492616376421, 828.0022572799792, 837.0165056059136, 838.9412741108125, 839.8404303182376, 839.9874001889946, 888.4802390601506, 889.888763904512, 889.9377043606918, 890.688259109313, 890.8663700444953, 740.4409670698615, 881.2113158722939, 901.3555307954844, 903.029243563169, 904.8326059678915, 653.5490511547017, 658.1345530627258, 658.4337469775988, 658.4469046001382, 658.5061204096927, 14312.499062532865, 14372.281385930663, 14401.063930844566, 14420.495282665057, 14436.566902992927, 13665.931670341584, 13924.234167120805, 14021.789673154808, 14052.859471405258, 14106.0, 12404.689882752913, 12563.685907852285, 12673.683157921034, 12719.618411447671, 12807.231566106064, 4164.597938553789, 4166.500019997589, 4203.91592168155, 4209.179210054041, 4214.515330736974, 54406.18390724142, 54564.454355456335, 55894.0, 55997.0, 56605.43394566084, 10552.577896884191, 10819.621313253998, 10963.0, 11162.386068766296, 11241.83137252942, 18884.905575472036, 18967.33614323492, 19087.61824763497, 19168.71246931297, 19176.137073831713, 8157.829101611284, 8341.582920853933, 8414.789630259293, 8565.443246188977, 8657.826843463095, 4879.463259041502, 4883.560479556786, 4951.702897826142, 4985.252212168204, 5024.748762561857, 3309.6855798699085, 3382.30662714143, 3390.983045084759, 3391.6269210386836, 3395.3209358128474, 642.6465444005778, 642.7139922734432, 651.6806764685365, 652.6051738698019, 655.2366493035655, 614.7663887722637, 621.9253689557282, 705.7071315404049, 730.2478447199393, 762.0208032677982, 9188.264938805014, 9486.95256523713, 9613.423194608346, 9641.228701703987, 9664.323497355259, 598.1745191635515, 648.1703419622796, 655.5214693273937, 808.9191080891982, 829.8713699376606, 4797.5607317804515, 4858.659893807399, 4866.294387313819, 4891.095147397743, 4919.0899683558655, 55813.72093139508, 57462.425375745705, 57654.0, 66914.33085669178, 68217.65891170512, 54627.453725463034, 55145.724271378385, 56115.43884561184, 57886.7105664469, 58271.0, 52745.0, 52773.0, 53142.0, 54640.0, 55215.0, 9523.095305945924, 9659.206586454868, 9758.902410976083, 9797.608095676092, 9874.605015799287, 33132.33735325232, 33523.664763352055, 33719.4942075874, 33730.325393491505, 35373.82313088521, 42394.364084539375, 45454.77272613616, 46069.30896036629, 46406.53593464157, 47488.762556187, 12503.312317822243, 12693.619191424272, 12802.615921522369, 12943.417546210254, 13324.000699947737, 14375.85624143787, 14453.205073721047, 14461.0, 14979.775303370241, 15315.540533784004, 13842.238676872466, 13847.307634618028, 13912.0, 14440.277986100442, 14568.198749068903, 13618.795718064039, 13626.52307169284, 14197.787033194716, 14241.857581424467, 14264.857351426768, 13106.737865242832, 13158.276294803878, 13264.0, 13412.32938353098, 14010.719785604435, 11087.223894327642, 11249.606263780728, 11466.656000320003, 11566.30602163873, 11745.1191160665, 11335.4470766532, 11488.138389620644, 11547.4803633835, 11660.30038197711, 11703.707407314885], "value": 6992.861742869877, "unit": "score"}], "name": "dromaeo_css", "value": 7097.388046652621, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 112.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 155.0, 178.0, 125.0, 161.0, 154.0, 136.0, 174.0, 141.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 161.0, 160.0, 160.0, 159.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 115.0, 75.0, 75.0, 76.0, 74.0, 133.0, 75.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 122.0, 91.0, 92.0, 91.0, 119.0, 92.0, 92.0, 119.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 62.0, 62.0, 60.0, 60.0, 78.0, 59.0, 58.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 57.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 85.0, 81.0, 79.0, 79.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 138.0, 136.0, 129.0, 124.0, 122.0, 124.0, 130.0, 216.0, 129.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 171.0, 167.0, 167.0, 167.0, 168.0, 174.0, 169.0, 166.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1536.0, "alertThreshold": 2.0}]} 04:17:02 INFO - Return code: 0 04:17:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:17:02 ERROR - # TBPL SUCCESS # 04:17:02 INFO - Running post-action listener: _resource_record_post_action 04:17:02 INFO - ##### 04:17:02 INFO - ##### Finished run-tests step (success) 04:17:02 INFO - ##### 04:17:02 INFO - Running post-run listener: _resource_record_post_run 04:17:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536518656; Read time: 20; Write time: 361040 04:17:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 151355392; Read time: 0; Write time: 128492 04:17:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291672064; Read time: 20; Write time: 178516 04:17:03 INFO - Running post-run listener: _upload_blobber_files 04:17:03 INFO - Blob upload gear active. 04:17:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:03 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 04:17:03 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'] 04:17:03 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 04:17:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:04 INFO - (blobuploader) - INFO - Done attempting. 04:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:05 INFO - (blobuploader) - INFO - Done attempting. 04:17:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:05 INFO - Return code: 0 04:17:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5f8abab501f0212558292fe1330e8d24924418b49f64baa203e266d45e61c1adff28b30211725f6e90293c0dc7d982a26c43cdf54d9974a5d2f982741a6c6fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32bfcc6ed0962c12494b583b2a3e29471bd81b27fcee9389e84478913bfb6b43dc7c54cf3f5783bd80260f8bf9ddc2d124ff12a3bde52239b4dab1fae0aa3a80"} 04:17:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:05 INFO - Contents: 04:17:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5f8abab501f0212558292fe1330e8d24924418b49f64baa203e266d45e61c1adff28b30211725f6e90293c0dc7d982a26c43cdf54d9974a5d2f982741a6c6fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32bfcc6ed0962c12494b583b2a3e29471bd81b27fcee9389e84478913bfb6b43dc7c54cf3f5783bd80260f8bf9ddc2d124ff12a3bde52239b4dab1fae0aa3a80"} 04:17:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:05 INFO - Copying logs to upload dir... 04:17:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.808006 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-06 04:17:05.506948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:17:05.510948) ========= 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=00204705a9daa57ed339a427000001b9-1462532075.292321-620422555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5f8abab501f0212558292fe1330e8d24924418b49f64baa203e266d45e61c1adff28b30211725f6e90293c0dc7d982a26c43cdf54d9974a5d2f982741a6c6fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32bfcc6ed0962c12494b583b2a3e29471bd81b27fcee9389e84478913bfb6b43dc7c54cf3f5783bd80260f8bf9ddc2d124ff12a3bde52239b4dab1fae0aa3a80"} build_url:https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/ZFw_ilPIT_634oEO6iLq2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5f8abab501f0212558292fe1330e8d24924418b49f64baa203e266d45e61c1adff28b30211725f6e90293c0dc7d982a26c43cdf54d9974a5d2f982741a6c6fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32bfcc6ed0962c12494b583b2a3e29471bd81b27fcee9389e84478913bfb6b43dc7c54cf3f5783bd80260f8bf9ddc2d124ff12a3bde52239b4dab1fae0aa3a80"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:17:05.535979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:17:05.536301) ========= 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=00204705a9daa57ed339a427000001b9-1462532075.292321-620422555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:17:05.618544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:17:05.618853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:17:05.619145) ========= ========= Total master_lag: 0.17 =========