builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1463072740.86 results: success (0) buildid: 20160512073659 builduid: ed9d529ff5854bcdb4dda57b7c086c67 revision: 70dc1787f866ac056bbe3d01eda5a039c41ad74f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:40.861850) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:40.862456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:40.862796) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:40.891704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:40.892129) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 10:05:41-- 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% 221M=0s 2016-05-12 10:05:41 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082210 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:40.988984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:40.989471) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023263 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:41.041340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:41.041734) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 70dc1787f866ac056bbe3d01eda5a039c41ad74f --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 70dc1787f866ac056bbe3d01eda5a039c41ad74f --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=a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 10:05:41,294 truncating revision to first 12 chars 2016-05-12 10:05:41,294 Setting DEBUG logging. 2016-05-12 10:05:41,294 attempt 1/10 2016-05-12 10:05:41,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/70dc1787f866?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 10:05:41,567 unpacking tar archive at: mozilla-inbound-70dc1787f866/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558309 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:41.630138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:41.630733) ========= script_repo_revision: 70dc1787f866ac056bbe3d01eda5a039c41ad74f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:41.631488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:41.632020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 10:05:41.683470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-12 10:05:41.684145) ========= /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=a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:42 INFO - MultiFileLogger online at 20160512 10:05:42 in /builds/slave/test 10:05:42 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 10:05:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:42 INFO - {'append_to_log': False, 10:05:42 INFO - 'base_work_dir': '/builds/slave/test', 10:05:42 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:05:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:42 INFO - 'branch': 'Mozilla-Inbound', 10:05:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:42 INFO - 'config_files': ('talos/linux_config.py',), 10:05:42 INFO - 'default_actions': ('clobber', 10:05:42 INFO - 'read-buildbot-config', 10:05:42 INFO - 'download-and-extract', 10:05:42 INFO - 'populate-webroot', 10:05:42 INFO - 'create-virtualenv', 10:05:42 INFO - 'install', 10:05:42 INFO - 'run-tests'), 10:05:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:42 INFO - 'download_minidump_stackwalk': True, 10:05:42 INFO - 'download_symbols': 'ondemand', 10:05:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:42 INFO - 'installer_path': 'installer.exe', 10:05:42 INFO - 'log_level': 'info', 10:05:42 INFO - 'log_name': 'talos', 10:05:42 INFO - 'log_to_console': True, 10:05:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:42 INFO - 'opt_config_files': (), 10:05:42 INFO - 'pip_index': False, 10:05:42 INFO - 'sps_profile': False, 10:05:42 INFO - 'sps_profile_interval': 0, 10:05:42 INFO - 'suite': 'dromaeojs', 10:05:42 INFO - 'system_bits': '32', 10:05:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:42 INFO - 'title': 'talos-linux64-ix-002', 10:05:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:42 INFO - 'use_talos_json': True, 10:05:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:42 INFO - 'work_dir': 'build'} 10:05:42 INFO - ##### 10:05:42 INFO - ##### Running clobber step. 10:05:42 INFO - ##### 10:05:42 INFO - Running pre-action listener: _resource_record_pre_action 10:05:42 INFO - Running main action method: clobber 10:05:42 INFO - rmtree: /builds/slave/test/build 10:05:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:42 INFO - Running post-action listener: _resource_record_post_action 10:05:42 INFO - ##### 10:05:42 INFO - ##### Finished clobber step (success) 10:05:42 INFO - ##### 10:05:42 INFO - ##### 10:05:42 INFO - ##### Running read-buildbot-config step. 10:05:42 INFO - ##### 10:05:42 INFO - Running pre-action listener: _resource_record_pre_action 10:05:42 INFO - Running main action method: read_buildbot_config 10:05:42 INFO - Using buildbot properties: 10:05:42 INFO - { 10:05:42 INFO - "project": "", 10:05:42 INFO - "product": "firefox", 10:05:42 INFO - "script_repo_revision": "production", 10:05:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:05:42 INFO - "repository": "", 10:05:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:05:42 INFO - "buildid": "20160512073659", 10:05:42 INFO - "pgo_build": "True", 10:05:42 INFO - "basedir": "/builds/slave/test", 10:05:42 INFO - "buildnumber": 1803, 10:05:42 INFO - "slavename": "talos-linux64-ix-002", 10:05:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:05:42 INFO - "platform": "ubuntu64_hw", 10:05:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:05:42 INFO - "branch": "mozilla-inbound", 10:05:42 INFO - "repo_path": "integration/mozilla-inbound", 10:05:42 INFO - "revision": "70dc1787f866ac056bbe3d01eda5a039c41ad74f", 10:05:42 INFO - "stage_platform": "linux64-pgo", 10:05:42 INFO - "builduid": "ed9d529ff5854bcdb4dda57b7c086c67", 10:05:42 INFO - "slavebuilddir": "test" 10:05:42 INFO - } 10:05:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:05:42 INFO - Running post-action listener: _resource_record_post_action 10:05:42 INFO - ##### 10:05:42 INFO - ##### Finished read-buildbot-config step (success) 10:05:42 INFO - ##### 10:05:42 INFO - ##### 10:05:42 INFO - ##### Running download-and-extract step. 10:05:42 INFO - ##### 10:05:42 INFO - Running pre-action listener: _resource_record_pre_action 10:05:42 INFO - Running main action method: download_and_extract 10:05:42 INFO - mkdir: /builds/slave/test/build/tests 10:05: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')]} 10:05:42 INFO - https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:05:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:05:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:05:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:43 INFO - Downloaded 1361 bytes. 10:05:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:05:43 INFO - Using the following test package requirements: 10:05:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:05:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:43 INFO - u'jsshell-linux-x86_64.zip'], 10:05:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:43 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')]} 10:05:43 INFO - https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:44 INFO - Downloaded 23907276 bytes. 10:05:44 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'] 10:05:44 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 10:05:45 INFO - Return code: 0 10:05:45 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 10:05:45 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')]} 10:05:45 INFO - https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:47 INFO - Downloaded 23907276 bytes. 10:05:47 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'] 10:05:47 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 10:05:48 INFO - Return code: 0 10:05: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')]} 10:05:48 INFO - https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:49 INFO - Downloaded 10840239 bytes. 10:05:49 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'] 10:05:49 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 10:05:49 INFO - Return code: 0 10:05:49 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')]} 10:05:49 INFO - https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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 10:05:51 INFO - Downloaded 58361680 bytes. 10:05:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:51 INFO - mkdir: /builds/slave/test/properties 10:05:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:51 INFO - Contents: 10:05:51 INFO - build_url:https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:52 INFO - Running post-action listener: _resource_record_post_action 10:05:52 INFO - Running post-action listener: set_extra_try_arguments 10:05:52 INFO - ##### 10:05:52 INFO - ##### Finished download-and-extract step (success) 10:05:52 INFO - ##### 10:05:52 INFO - ##### 10:05:52 INFO - ##### Running populate-webroot step. 10:05:52 INFO - ##### 10:05:52 INFO - Running pre-action listener: _resource_record_pre_action 10:05:52 INFO - Running main action method: populate_webroot 10:05:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:52 INFO - '--tppagecycles', 10:05:52 INFO - '7'], 10:05:52 INFO - 'tests': ['tsvgm']}}, 10:05:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:52 INFO - 'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:52 INFO - 'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['damp', 'tps']}, 10:05:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:52 INFO - 'tests': ['damp', 'tps']}, 10:05:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['dromaeo_dom']}, 10:05:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['a11yr', 10:05:52 INFO - 'ts_paint', 10:05:52 INFO - 'tpaint', 10:05:52 INFO - 'sessionrestore', 10:05:52 INFO - 'sessionrestore_no_auto_restore', 10:05:52 INFO - 'tabpaint']}, 10:05:52 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:52 INFO - 'ts_paint', 10:05:52 INFO - 'tpaint', 10:05:52 INFO - 'sessionrestore', 10:05:52 INFO - 'sessionrestore_no_auto_restore', 10:05:52 INFO - 'tabpaint']}, 10:05:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:52 INFO - 'ts_paint', 10:05:52 INFO - 'tpaint', 10:05:52 INFO - 'sessionrestore', 10:05:52 INFO - 'sessionrestore_no_auto_restore', 10:05:52 INFO - 'tabpaint']}, 10:05:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:52 INFO - 'ts_paint', 10:05:52 INFO - 'tpaint', 10:05:52 INFO - 'sessionrestore', 10:05:52 INFO - 'sessionrestore_no_auto_restore', 10:05:52 INFO - 'tabpaint']}, 10:05:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['a11yr', 10:05:52 INFO - 'ts_paint', 10:05:52 INFO - 'tpaint', 10:05:52 INFO - 'sessionrestore', 10:05:52 INFO - 'sessionrestore_no_auto_restore', 10:05:52 INFO - 'tabpaint']}, 10:05:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['a11yr', 10:05:52 INFO - 'ts_paint', 10:05:52 INFO - 'tpaint', 10:05:52 INFO - 'sessionrestore', 10:05:52 INFO - 'sessionrestore_no_auto_restore', 10:05:52 INFO - 'tabpaint']}, 10:05:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['tsvgx', 10:05:52 INFO - 'tsvgr_opacity', 10:05:52 INFO - 'tart', 10:05:52 INFO - 'tscrollx', 10:05:52 INFO - 'cart']}, 10:05:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:52 INFO - 'tsvgr_opacity', 10:05:52 INFO - 'tart', 10:05:52 INFO - 'tscrollx', 10:05:52 INFO - 'cart']}, 10:05:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:52 INFO - 'talos_options': ['--disable-e10s'], 10:05:52 INFO - 'tests': ['tp5o']}, 10:05:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:52 INFO - 'tests': ['tp5o']}, 10:05:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:52 INFO - 'talos_options': ['--disable-e10s', 10:05:52 INFO - '--xperf_path', 10:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:52 INFO - 'tests': ['tp5n']}, 10:05:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:52 INFO - 'talos_options': ['--xperf_path', 10:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:52 INFO - 'tests': ['tp5n']}}, 10:05:52 INFO - 'talos.zip': {'path': '', 10:05:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:52 INFO - Running post-action listener: _resource_record_post_action 10:05:52 INFO - ##### 10:05:52 INFO - ##### Finished populate-webroot step (success) 10:05:52 INFO - ##### 10:05:52 INFO - ##### 10:05:52 INFO - ##### Running create-virtualenv step. 10:05:52 INFO - ##### 10:05:52 INFO - Running pre-action listener: _resource_record_pre_action 10:05:52 INFO - Running main action method: create_virtualenv 10:05:52 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:52 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 10:05:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:52 INFO - Using real prefix '/usr' 10:05:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:54 INFO - Installing pip.................done. 10:05:54 INFO - Return code: 0 10:05:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:54 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')]} 10:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:54 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')]} 10:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:54 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:05:54 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 10:05:54 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 10:05:54 INFO - Using env: {'DISPLAY': ':0', 10:05:54 INFO - 'HOME': '/home/cltbld', 10:05:54 INFO - 'LANG': 'en_US.UTF-8', 10:05:54 INFO - 'LANGUAGE': 'en_US:en', 10:05:54 INFO - 'LOGNAME': 'cltbld', 10:05:54 INFO - 'MAIL': '/var/mail/cltbld', 10:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:54 INFO - 'MOZ_NO_REMOTE': '1', 10:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:54 INFO - 'NO_EM_RESTART': '1', 10:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:54 INFO - 'PWD': '/builds/slave/test', 10:05:54 INFO - 'SHELL': '/bin/bash', 10:05:54 INFO - 'SHLVL': '1', 10:05:54 INFO - 'TERM': 'linux', 10:05:54 INFO - 'TMOUT': '86400', 10:05:54 INFO - 'USER': 'cltbld', 10:05:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:54 INFO - '_': '/tools/buildbot/bin/python'} 10:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:54 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 10:05:54 INFO - Cleaning up... 10:05:54 INFO - Return code: 0 10:05:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:05:54 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')]} 10:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:54 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')]} 10:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:54 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:05:54 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 10:05:54 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 10:05:54 INFO - Using env: {'DISPLAY': ':0', 10:05:54 INFO - 'HOME': '/home/cltbld', 10:05:54 INFO - 'LANG': 'en_US.UTF-8', 10:05:54 INFO - 'LANGUAGE': 'en_US:en', 10:05:54 INFO - 'LOGNAME': 'cltbld', 10:05:54 INFO - 'MAIL': '/var/mail/cltbld', 10:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:54 INFO - 'MOZ_NO_REMOTE': '1', 10:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:54 INFO - 'NO_EM_RESTART': '1', 10:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:54 INFO - 'PWD': '/builds/slave/test', 10:05:54 INFO - 'SHELL': '/bin/bash', 10:05:54 INFO - 'SHLVL': '1', 10:05:54 INFO - 'TERM': 'linux', 10:05:54 INFO - 'TMOUT': '86400', 10:05:54 INFO - 'USER': 'cltbld', 10:05:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:54 INFO - '_': '/tools/buildbot/bin/python'} 10:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:55 INFO - Downloading/unpacking psutil>=0.7.1 10:05:55 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 10:05:55 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 10:05:55 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 10:05:55 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 10:05:55 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 10:05:55 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 10:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:57 INFO - Installing collected packages: psutil 10:05:57 INFO - Running setup.py install for psutil 10:05:57 INFO - building 'psutil._psutil_linux' extension 10:05:57 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 10:05:57 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 10:05:57 INFO - building 'psutil._psutil_posix' extension 10:05:57 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 10:05:57 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 10:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:57 INFO - Successfully installed psutil 10:05:57 INFO - Cleaning up... 10:05:57 INFO - Return code: 0 10:05:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:57 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:05:57 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 10:05:57 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 10:05:57 INFO - Using env: {'DISPLAY': ':0', 10:05:57 INFO - 'HOME': '/home/cltbld', 10:05:57 INFO - 'LANG': 'en_US.UTF-8', 10:05:57 INFO - 'LANGUAGE': 'en_US:en', 10:05:57 INFO - 'LOGNAME': 'cltbld', 10:05:57 INFO - 'MAIL': '/var/mail/cltbld', 10:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:57 INFO - 'MOZ_NO_REMOTE': '1', 10:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:57 INFO - 'NO_EM_RESTART': '1', 10:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:57 INFO - 'PWD': '/builds/slave/test', 10:05:57 INFO - 'SHELL': '/bin/bash', 10:05:57 INFO - 'SHLVL': '1', 10:05:57 INFO - 'TERM': 'linux', 10:05:57 INFO - 'TMOUT': '86400', 10:05:57 INFO - 'USER': 'cltbld', 10:05:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:57 INFO - '_': '/tools/buildbot/bin/python'} 10:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:05:59 INFO - Installing collected packages: mozsystemmonitor 10:05:59 INFO - Running setup.py install for mozsystemmonitor 10:05:59 INFO - Successfully installed mozsystemmonitor 10:05:59 INFO - Cleaning up... 10:05:59 INFO - Return code: 0 10:05:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:59 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')]} 10:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 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')]} 10:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:05:59 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 10:05:59 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 10:05:59 INFO - Using env: {'DISPLAY': ':0', 10:05:59 INFO - 'HOME': '/home/cltbld', 10:05:59 INFO - 'LANG': 'en_US.UTF-8', 10:05:59 INFO - 'LANGUAGE': 'en_US:en', 10:05:59 INFO - 'LOGNAME': 'cltbld', 10:05:59 INFO - 'MAIL': '/var/mail/cltbld', 10:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:59 INFO - 'MOZ_NO_REMOTE': '1', 10:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:59 INFO - 'NO_EM_RESTART': '1', 10:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:59 INFO - 'PWD': '/builds/slave/test', 10:05:59 INFO - 'SHELL': '/bin/bash', 10:05:59 INFO - 'SHLVL': '1', 10:05:59 INFO - 'TERM': 'linux', 10:05:59 INFO - 'TMOUT': '86400', 10:05:59 INFO - 'USER': 'cltbld', 10:05:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:59 INFO - '_': '/tools/buildbot/bin/python'} 10:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:00 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 10:06:00 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 10:06:00 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 10:06:00 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 10:06:00 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 10:06:00 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 10:06:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:02 INFO - Downloading docopt-0.6.1.tar.gz 10:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:02 INFO - Running setup.py install for blobuploader 10:06:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:02 INFO - Running setup.py install for requests 10:06:03 INFO - Running setup.py install for docopt 10:06:03 INFO - Successfully installed blobuploader requests docopt 10:06:03 INFO - Cleaning up... 10:06:03 INFO - Return code: 0 10:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:06:03 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 10:06:03 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 10:06:03 INFO - Using env: {'DISPLAY': ':0', 10:06:03 INFO - 'HOME': '/home/cltbld', 10:06:03 INFO - 'LANG': 'en_US.UTF-8', 10:06:03 INFO - 'LANGUAGE': 'en_US:en', 10:06:03 INFO - 'LOGNAME': 'cltbld', 10:06:03 INFO - 'MAIL': '/var/mail/cltbld', 10:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:03 INFO - 'MOZ_NO_REMOTE': '1', 10:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:03 INFO - 'NO_EM_RESTART': '1', 10:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:03 INFO - 'PWD': '/builds/slave/test', 10:06:03 INFO - 'SHELL': '/bin/bash', 10:06:03 INFO - 'SHLVL': '1', 10:06:03 INFO - 'TERM': 'linux', 10:06:03 INFO - 'TMOUT': '86400', 10:06:03 INFO - 'USER': 'cltbld', 10:06:03 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:03 INFO - '_': '/tools/buildbot/bin/python'} 10:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:03 INFO - Running setup.py (path:/tmp/pip-M_AOxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:03 INFO - Running setup.py (path:/tmp/pip-rmJy7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:03 INFO - Running setup.py (path:/tmp/pip-Rf9vFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:03 INFO - Running setup.py (path:/tmp/pip-TXRgEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:03 INFO - Running setup.py (path:/tmp/pip-j6TuRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:03 INFO - Running setup.py (path:/tmp/pip-uKU5cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:04 INFO - Running setup.py (path:/tmp/pip-gpU3J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:04 INFO - Running setup.py (path:/tmp/pip-KCmx5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:04 INFO - Running setup.py (path:/tmp/pip-tmgnLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:04 INFO - Running setup.py (path:/tmp/pip-W6TEmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:04 INFO - Running setup.py (path:/tmp/pip-UV7XMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:04 INFO - Running setup.py (path:/tmp/pip-VxNI9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:04 INFO - Running setup.py (path:/tmp/pip-CIYsFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:04 INFO - Running setup.py (path:/tmp/pip-EvQwfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:04 INFO - Running setup.py (path:/tmp/pip-CpqIUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:04 INFO - Running setup.py (path:/tmp/pip-kb8XeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:04 INFO - Running setup.py (path:/tmp/pip-wl6nUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:04 INFO - Running setup.py install for manifestparser 10:06:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:04 INFO - Running setup.py install for mozcrash 10:06:05 INFO - Running setup.py install for mozdebug 10:06:05 INFO - Running setup.py install for mozdevice 10:06:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Running setup.py install for mozfile 10:06:05 INFO - Running setup.py install for mozhttpd 10:06:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Running setup.py install for mozinfo 10:06:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Running setup.py install for mozInstall 10:06:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Running setup.py install for mozleak 10:06:05 INFO - Running setup.py install for mozlog 10:06:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Running setup.py install for moznetwork 10:06:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:05 INFO - Running setup.py install for mozprocess 10:06:06 INFO - Running setup.py install for mozprofile 10:06:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:06 INFO - Running setup.py install for mozrunner 10:06:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:06 INFO - Running setup.py install for mozscreenshot 10:06:06 INFO - Running setup.py install for moztest 10:06:06 INFO - Running setup.py install for mozversion 10:06:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:06 INFO - Cleaning up... 10:06:06 INFO - Return code: 0 10:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:06:06 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 10:06:06 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 10:06:06 INFO - Using env: {'DISPLAY': ':0', 10:06:06 INFO - 'HOME': '/home/cltbld', 10:06:06 INFO - 'LANG': 'en_US.UTF-8', 10:06:06 INFO - 'LANGUAGE': 'en_US:en', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MAIL': '/var/mail/cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SHLVL': '1', 10:06:06 INFO - 'TERM': 'linux', 10:06:06 INFO - 'TMOUT': '86400', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - '_': '/tools/buildbot/bin/python'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:06 INFO - Running setup.py (path:/tmp/pip-mZWcai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:06 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)) 10:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:06 INFO - Running setup.py (path:/tmp/pip-RCA9hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:06 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)) 10:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:06 INFO - Running setup.py (path:/tmp/pip-ctk9pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:07 INFO - Running setup.py (path:/tmp/pip-qQP3g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:07 INFO - Running setup.py (path:/tmp/pip-AVj5kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:07 INFO - Running setup.py (path:/tmp/pip-ocvAQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:07 INFO - Running setup.py (path:/tmp/pip-69ctxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:07 INFO - Running setup.py (path:/tmp/pip-x7sJE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:07 INFO - Running setup.py (path:/tmp/pip-NayKgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:07 INFO - Running setup.py (path:/tmp/pip-j_fAI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:07 INFO - Running setup.py (path:/tmp/pip-Vo_Wbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:07 INFO - Running setup.py (path:/tmp/pip-_l44Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:07 INFO - Running setup.py (path:/tmp/pip-0kkjkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:07 INFO - Running setup.py (path:/tmp/pip-0MwsjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:07 INFO - Running setup.py (path:/tmp/pip-RBpWXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:07 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)) 10:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:07 INFO - Running setup.py (path:/tmp/pip-TQARIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:08 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)) 10:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:08 INFO - Running setup.py (path:/tmp/pip-rVrtX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:08 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)) 10:06:08 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)) 10:06:08 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)) 10:06:08 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)) 10:06:08 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)) 10:06:08 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)) 10:06:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:09 INFO - Downloading blessings-1.6.tar.gz 10:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:10 INFO - Installing collected packages: blessings 10:06:10 INFO - Running setup.py install for blessings 10:06:10 INFO - Successfully installed blessings 10:06:10 INFO - Cleaning up... 10:06:10 INFO - Return code: 0 10:06:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:10 INFO - Reading from file tmpfile_stdout 10:06:10 INFO - Current package versions: 10:06:10 INFO - argparse == 1.2.1 10:06:10 INFO - blessings == 1.6 10:06:10 INFO - blobuploader == 1.2.4 10:06:10 INFO - docopt == 0.6.1 10:06:10 INFO - manifestparser == 1.1 10:06:10 INFO - mozInstall == 1.12 10:06:10 INFO - mozcrash == 0.17 10:06:10 INFO - mozdebug == 0.1 10:06:10 INFO - mozdevice == 0.48 10:06:10 INFO - mozfile == 1.2 10:06:10 INFO - mozhttpd == 0.7 10:06:10 INFO - mozinfo == 0.9 10:06:10 INFO - mozleak == 0.1 10:06:10 INFO - mozlog == 3.2 10:06:10 INFO - moznetwork == 0.27 10:06:10 INFO - mozprocess == 0.22 10:06:10 INFO - mozprofile == 0.28 10:06:10 INFO - mozrunner == 6.11 10:06:10 INFO - mozscreenshot == 0.1 10:06:10 INFO - mozsystemmonitor == 0.0 10:06:10 INFO - moztest == 0.7 10:06:10 INFO - mozversion == 1.4 10:06:10 INFO - psutil == 3.1.1 10:06:10 INFO - requests == 1.2.3 10:06:10 INFO - wsgiref == 0.1.2 10:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:10 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')]} 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:10 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')]} 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:10 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:06:10 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 10:06:10 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 10:06:10 INFO - Using env: {'DISPLAY': ':0', 10:06:10 INFO - 'HOME': '/home/cltbld', 10:06:10 INFO - 'LANG': 'en_US.UTF-8', 10:06:10 INFO - 'LANGUAGE': 'en_US:en', 10:06:10 INFO - 'LOGNAME': 'cltbld', 10:06:10 INFO - 'MAIL': '/var/mail/cltbld', 10:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:10 INFO - 'MOZ_NO_REMOTE': '1', 10:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:10 INFO - 'NO_EM_RESTART': '1', 10:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:10 INFO - 'PWD': '/builds/slave/test', 10:06:10 INFO - 'SHELL': '/bin/bash', 10:06:10 INFO - 'SHLVL': '1', 10:06:10 INFO - 'TERM': 'linux', 10:06:10 INFO - 'TMOUT': '86400', 10:06:10 INFO - 'USER': 'cltbld', 10:06:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:10 INFO - '_': '/tools/buildbot/bin/python'} 10:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 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)) 10:06:10 INFO - Cleaning up... 10:06:10 INFO - Return code: 0 10:06:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:10 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')]} 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:10 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')]} 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:10 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:06:10 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 10:06:10 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 10:06:10 INFO - Using env: {'DISPLAY': ':0', 10:06:10 INFO - 'HOME': '/home/cltbld', 10:06:10 INFO - 'LANG': 'en_US.UTF-8', 10:06:10 INFO - 'LANGUAGE': 'en_US:en', 10:06:10 INFO - 'LOGNAME': 'cltbld', 10:06:10 INFO - 'MAIL': '/var/mail/cltbld', 10:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:10 INFO - 'MOZ_NO_REMOTE': '1', 10:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:10 INFO - 'NO_EM_RESTART': '1', 10:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:10 INFO - 'PWD': '/builds/slave/test', 10:06:10 INFO - 'SHELL': '/bin/bash', 10:06:10 INFO - 'SHLVL': '1', 10:06:10 INFO - 'TERM': 'linux', 10:06:10 INFO - 'TMOUT': '86400', 10:06:10 INFO - 'USER': 'cltbld', 10:06:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:10 INFO - '_': '/tools/buildbot/bin/python'} 10:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:10 INFO - Downloading/unpacking jsonschema 10:06:10 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 10:06:10 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 10:06:10 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 10:06:10 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 10:06:10 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 10:06:10 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 10:06:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:12 INFO - Downloading/unpacking functools32 (from jsonschema) 10:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:12 INFO - warning: no files found matching '*.txt' 10:06:12 INFO - no previously-included directories found matching 'build' 10:06:12 INFO - no previously-included directories found matching 'dist' 10:06:12 INFO - no previously-included directories found matching '.git*' 10:06:12 INFO - Installing collected packages: jsonschema, functools32 10:06:13 INFO - Running setup.py install for functools32 10:06:13 INFO - warning: no files found matching '*.txt' 10:06:13 INFO - no previously-included directories found matching 'build' 10:06:13 INFO - no previously-included directories found matching 'dist' 10:06:13 INFO - no previously-included directories found matching '.git*' 10:06:13 INFO - Successfully installed jsonschema functools32 10:06:13 INFO - Cleaning up... 10:06:13 INFO - Return code: 0 10:06:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:06:13 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')]} 10:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:13 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')]} 10:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:13 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 0x7f01b1e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', '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 10:06:13 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 10:06:13 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 10:06:13 INFO - Using env: {'DISPLAY': ':0', 10:06:13 INFO - 'HOME': '/home/cltbld', 10:06:13 INFO - 'LANG': 'en_US.UTF-8', 10:06:13 INFO - 'LANGUAGE': 'en_US:en', 10:06:13 INFO - 'LOGNAME': 'cltbld', 10:06:13 INFO - 'MAIL': '/var/mail/cltbld', 10:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:13 INFO - 'MOZ_NO_REMOTE': '1', 10:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:13 INFO - 'NO_EM_RESTART': '1', 10:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:13 INFO - 'PWD': '/builds/slave/test', 10:06:13 INFO - 'SHELL': '/bin/bash', 10:06:13 INFO - 'SHLVL': '1', 10:06:13 INFO - 'TERM': 'linux', 10:06:13 INFO - 'TMOUT': '86400', 10:06:13 INFO - 'USER': 'cltbld', 10:06:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:13 INFO - '_': '/tools/buildbot/bin/python'} 10:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:13 INFO - Downloading/unpacking flake8 10:06:13 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 10:06:13 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 10:06:13 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 10:06:13 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 10:06:13 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 10:06:13 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 10:06:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:06:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:06:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:06:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:06:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:06:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:06:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:06:15 INFO - no previously-included directories found matching 'docs/_build' 10:06:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:06:16 INFO - Running setup.py install for pep8 10:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:06:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:06:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:06:16 INFO - no previously-included directories found matching 'docs/_build' 10:06:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:06:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:06:16 INFO - Cleaning up... 10:06:16 INFO - Return code: 0 10:06:16 INFO - Running post-action listener: _resource_record_post_action 10:06:16 INFO - Running post-action listener: _start_resource_monitoring 10:06:16 INFO - Starting resource monitoring. 10:06:16 INFO - ##### 10:06:16 INFO - ##### Finished create-virtualenv step (success) 10:06:16 INFO - ##### 10:06:16 INFO - ##### 10:06:16 INFO - ##### Running install step. 10:06:16 INFO - ##### 10:06:16 INFO - Running pre-action listener: _resource_record_pre_action 10:06:16 INFO - Running main action method: install 10:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:16 INFO - Reading from file tmpfile_stdout 10:06:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:16 INFO - Reading from file tmpfile_stdout 10:06:16 INFO - Output received: 10:06:16 INFO - Usage: mozinstall [options] installer 10:06:16 INFO - Options: 10:06:16 INFO - -h, --help show this help message and exit 10:06:16 INFO - -d DEST, --destination=DEST 10:06:16 INFO - Directory to install application into. [default: 10:06:16 INFO - "/builds/slave/test"] 10:06:16 INFO - --app=APP Application being installed. [default: firefox] 10:06:16 INFO - mkdir: /builds/slave/test/build/application 10:06:16 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'] 10:06:16 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 10:06:33 INFO - Reading from file tmpfile_stdout 10:06:33 INFO - Output received: 10:06:33 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:33 INFO - Running post-action listener: _resource_record_post_action 10:06:33 INFO - ##### 10:06:33 INFO - ##### Finished install step (success) 10:06:33 INFO - ##### 10:06:33 INFO - ##### 10:06:33 INFO - ##### Running run-tests step. 10:06:33 INFO - ##### 10:06:33 INFO - Running pre-action listener: _resource_record_pre_action 10:06:33 INFO - Running main action method: run_tests 10:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:33 INFO - Python 2.7.3 10:06:33 INFO - Return code: 0 10:06:33 INFO - grabbing minidump binary from tooltool 10:06: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')]} 10:06:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15999c0>, '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 0x159a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:33 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 10:06:33 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 10:06:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:06:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:33 INFO - Return code: 0 10:06:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:06:34 INFO - Return code: 0 10:06:34 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/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 10:06:34 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/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 10:06:34 INFO - Using env: {'DISPLAY': ':0', 10:06:34 INFO - 'HOME': '/home/cltbld', 10:06:34 INFO - 'LANG': 'en_US.UTF-8', 10:06:34 INFO - 'LANGUAGE': 'en_US:en', 10:06:34 INFO - 'LOGNAME': 'cltbld', 10:06:34 INFO - 'MAIL': '/var/mail/cltbld', 10:06:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:34 INFO - 'MOZ_NO_REMOTE': '1', 10:06:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:34 INFO - 'NO_EM_RESTART': '1', 10:06:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:34 INFO - 'PWD': '/builds/slave/test', 10:06:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:34 INFO - 'SHELL': '/bin/bash', 10:06:34 INFO - 'SHLVL': '1', 10:06:34 INFO - 'TERM': 'linux', 10:06:34 INFO - 'TMOUT': '86400', 10:06:34 INFO - 'USER': 'cltbld', 10:06:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982', 10:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:34 INFO - '_': '/tools/buildbot/bin/python'} 10:06:34 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/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 10:06:34 INFO - mozversion application_buildid: 20160512073659 10:06:34 INFO - mozversion application_changeset: 70dc1787f866ac056bbe3d01eda5a039c41ad74f 10:06:34 INFO - mozversion application_display_name: Nightly 10:06:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:34 INFO - mozversion application_name: Firefox 10:06:34 INFO - mozversion application_remotingname: firefox 10:06:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:06:34 INFO - mozversion application_vendor: Mozilla 10:06:34 INFO - mozversion application_version: 49.0a1 10:06:34 INFO - mozversion platform_buildid: 20160512073659 10:06:34 INFO - mozversion platform_changeset: 70dc1787f866ac056bbe3d01eda5a039c41ad74f 10:06:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:06:34 INFO - mozversion platform_version: 49.0a1 10:06:34 INFO - using testdate: 1463072794 10:06:34 INFO - actual date: 1463072794 10:06:34 INFO - starting webserver on 'localhost:54714' 10:06:34 INFO - SUITE-START | Running 2 tests 10:06:34 INFO - TEST-START | dromaeo_css 10:06:34 INFO - operating with platform_type : linux_ 10:06:34 INFO - Initialising browser for dromaeo_css test... 10:06:34 INFO - TEST-INFO | started process 16165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgyJKid/profile http://localhost:54714/getInfo.html) 10:06:38 INFO - PROCESS | 16165 | __metrics Screen width/height:1600/1200 10:06:38 INFO - PROCESS | 16165 | colorDepth:24 10:06:38 INFO - PROCESS | 16165 | Browser inner width/height: 1024/697 10:06:38 INFO - PROCESS | 16165 | __metrics 10:06:39 ERROR - PROCESS | 16165 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:06:40 INFO - TEST-INFO | 16165: exit 0 10:06:40 INFO - Browser initialized. 10:06:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:40 INFO - TEST-INFO | started process 16253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgyJKid/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:51 INFO - PROCESS | 16253 | RSS: Main: 152076288 10:06:51 INFO - PROCESS | 16253 | 10:07:43 INFO - PROCESS | 16253 | 1463072863084 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] 10:09:50 INFO - PROCESS | 16253 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54714/tests/dromaeo/cssquery-ext.html) 10:09:51 INFO - PROCESS | 16253 | RSS: Main: 254480384 10:09:51 INFO - PROCESS | 16253 | 10:12:54 INFO - PROCESS | 16253 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-ext.html (next: http://localhost:54714/tests/dromaeo/cssquery-jquery.html) 10:12:54 INFO - PROCESS | 16253 | RSS: Main: 232480768 10:12:54 INFO - PROCESS | 16253 | 10:15:56 INFO - PROCESS | 16253 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54714/tests/dromaeo/cssquery-mootools.html) 10:15:57 INFO - PROCESS | 16253 | RSS: Main: 247685120 10:15:57 INFO - PROCESS | 16253 | 10:18:59 INFO - PROCESS | 16253 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54714/tests/dromaeo/cssquery-prototype.html) 10:18:59 INFO - PROCESS | 16253 | RSS: Main: 236064768 10:18:59 INFO - PROCESS | 16253 | 10:22:02 INFO - PROCESS | 16253 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54714/tests/dromaeo/cssquery-yui.html) 10:22:02 INFO - PROCESS | 16253 | RSS: Main: 223477760 10:22:02 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-yui.html (next: http://localhost:54714/tests/dromaeo/cssquery-dojo.html) 10:25:05 INFO - PROCESS | 16253 | RSS: Main: 306688000 10:25:05 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | __start_tp_report 10:25:05 INFO - PROCESS | 16253 | _x_x_mozilla_page_load 10:25:05 INFO - PROCESS | 16253 | _x_x_mozilla_page_load_details 10:25:05 INFO - PROCESS | 16253 | |i|pagename|runs| 10:25:05 INFO - PROCESS | 16253 | |0;dojo.html;3188.1073299476147;3193.505006723957;3220.871165153394;3224.371247606715;3249.5450636910823;5240.423553409122;5312.73436328183;5316.494932981365;5403.567714582834;5445.428230035844;5306.4958828911285;5344.198370244456;5381.165919282507;5417.51242388185;5426.945730542693;4870.634702397326;4945.901081978358;4979.427365852919;4982.277569752384;5123.718195499246;4984.451710311862;5017.19724844025;5045.066662667418;5055.266986287004;5070.264811602334;4780.067886762065;4838.03239352131;4855.247436647308;4937.580305674022;4957.628177886637;4862.7325497097645;4914.90170196594;4992.251162325644;4995.675281106716;5029.497050294978;4813.687110337817;4943.036107958949;4957.529034741694;4957.851264462072;4961.131801934647;5259.868503287448;5328.360596728378;5351.170568561879;5391.002664507039;5395.433479484637;5813.79651712188;5824.271966004249;5829.921464529033;5857.560682948753;5858.970705146489;5687.061634830289;5797.768089276424;5872.412758724136;5897.380775018647;5941.257342832146;5447.073997420408;5530.115181570929;5538.584606154554;5539.584531160179;5545.528630066449;6005.159277701038;6005.789797357072;6039.849003774941;6050.9394906050375;6064.696765161724;5530.170474428787;5650.85872853182;5684.772609095672;5817.50551203144;5827.79602713903;5789.305283366023;5797;5802.0426629605645;5819.941800582024;5860.238169037998;5724.313082430135;5754.165645981309;5771.307443106854;5776.075827867521;5809.070548712186;5602.803901863415;5752.539796816244;5790.826275211666;5802.593818432669;5814.912776308359;4407.493138289074;4411.1618792429335;4413.404190434315;4414.646828253732;4453.1761624099;3953.9011524711536;3966.5835087315995;3978.542467616261;4005.118873847749;4019.2162528307285;5321.946780532146;5433.918491222635;5456.563474921997;5515.751791169407;5517.089680202722;5867.178594996704;5873.647581145145;5877.059670452707;5892.941070589325;5895.764169433174;5544.695041772741;5558.249636299129;5560.2493663355735;5573.108302671553;5575.275214222206;4849.636277279218;4937.604991600663;4951.455339912607;4977.726225057657;5006.4743201964;6007.219061521974;6026.337102918676;6040.7583696651645;6045.486133678686;6050.7277172526465;5649.971750141223;5836.387179346192;5854.590178687451;5865.14955331466;5865.178874957424;5996.67018313997;6033.18551995475;6055.122007308827;6084.6349219047;6092.086187071975;5741.712914354349;5784.392638772868;5788.421157884178;5788.739506722123;5797.391273916178;5644.407337229696;5768.221290125947;5891.852703682443;5899.557533184942;5900.291964964232;5636.746346414503;5673;5674.177244299636;5694.914576281276;5730.5702072345575;5623.690697011703;5674.092145256739;5686.687232202268;5690.2887139107615;5701.372848986691;5400.756965936621;5510.531604813636;5526.143447765603;5592.608517403743;5599.216109744721;5702.743376548148;5722.7710891563875;5732.799352022659;5743.195952566728;5744.569157313302;5555.138953462219;5582.469665381782;5586.832395028156;5603.663780173202;5624.156376543551 10:25:05 INFO - PROCESS | 16253 | |1;ext.html;611.95716299859;646.4149944300408;650.7754824585517;658.8550518885844;668.595499722668;34050.48924266135;36974.44538331924;37098.629013709855;37120.62879371206;44731;42206.366904496455;46103.53896461034;46110;46119.53880461194;46120.30819537701;8940.64237430502;9090.77273068172;9099.317551183654;9106.225970792491;9109.908900911005;8920.241779448756;8984.550772461384;9016.77458063547;9023.142801433885;9025.18773310402;8874.245689116433;8907.331950103768;8909.777255568597;8910.465372077664;8914;9032.593533291018;9060.411073280216;9069.863952040725;9074.820273364421;9080.909190908073;8932.15144561272;8979.595918183697;8997.145271199226;8998.730038098867;8999.910000900038;43019.78490107561;43226.78386608047;43256.56743432588;43258.56741432577;43317.35023974643;3476.5654293213347;3583.6774690278;3583.8924832254816;3602.2615363850346;3605.369060414417;32065.198370040704;32231.83884080588;32375.352492950246;32610.836945815357;33285;4014.959850401488;4022.1352409232154;4029.4157347184787;4097.44684467596;4170.22850772608;326618;326676;327051;327072;327706;61546.38453615496;61736.38263617306;61895;62168.37831621626;62315.6884215576;37555.81222093872;38060.80969595134;38130.80934595365;65896.34103658902;66024.66987665031;16307.266173022243;16330.918345408198;16365.181740912907;16388.590285242964;16396.26216820246;13685.384157712926;13803.861961380258;13812.585622431143;13818.309084545934;13827.239501827496;20623.896880515502;20816;20821.479463013548;20833.479163020744;20857.582848342947;7492.400607951351;7524.833650784137;7570.886436703454;7603;7837.177096404909;1014.5992333028413;1093.9781204376027;1130.6777568392968;1137.2550979108696;1194.4147367789722;32980.340393192004;33341.16647083842;33604.66395336064;33788.0052581335;34029.31941361159;1156.5605070073486;1172.261475270574;1173.3194747046693;1198.6404078776332;1302.101549930545;17941.551461213574;17995.910020450076;18038;18119.72820407695;18249.36127235567;492065;492509;496033;496984;498550;61640.38359616436;62264;62405;62609;62659.37340626535;1320.7028418605737;1392.5126205828083;1428.8714015738633;1431.9069260498034;1451.3614009835849;33090.5036424449;34487.7582957107;34976.65023349836;35233.64766352406;35347.46978795269;52745.47254527405;52763;52903;52985.47014529805;53007;389762;393453;393703;394031;394483;26504;28509.857450712614;29480;29481.115566533037;30453.695463045085;48759.26861097015;49719.25421118614;50056.249156261954;50411;50597;41515.58484415238;41701.37447938344;41824.16351673011;42749.14501709886;43023.56976430321;41708.58291417168;41811.581884181986;42134.15731685288;42226;42681;41809.37285940774;41847.1630567393;42862.57137428711;42936;43031.7848410756;34548.82725586356;36781.44827827531;36886.26227475489;37199.442008369355;37258.813705931294;28820.558972051735;29085.85457072701;30587.54118688177;31214;31439.52840707437 10:25:05 INFO - PROCESS | 16253 | |2;jquery.html;411.7138588680866;416.3297091682391;417.6450017485138;419.1198483185313;425.50216246991016;14065.507707230223;18472.076396180204;19004.524886877836;19079.23683052678;20183.69724454131;14755.48355807547;18235.179416926236;18358.72461913069;18758.62482750344;19571.21715131393;5668.829935101953;5715.628484148517;5726.226959360495;5742.39704830993;5897.793577224798;5734.311882574097;5806.187133801272;5838.854028649275;5839.474447299742;5854.912176317359;4078.163976384849;6108.755649774003;6359.586626869239;6421;6525.086487891699;6432.517561182884;6476.773312934049;6502.804915852508;6510.511711621623;6523.412892839619;5634.943650563483;5697.031504644179;5725.227094342252;5787.623804452697;5789.392113828072;22664.546709065726;22910.65634015491;23103.653445198335;23157.0737170513;23189.420264493354;2305.342977251475;2317.9072837086665;2355.387599224197;2387.8089752819733;2415.903363865443;13126.2124272543;14380.137191768526;14442.133471991714;14580;14890.478833240893;1986.3147214211074;2014.2345908554803;2050.733404657385;2071.533904871407;2090.937271881846;80508.59745701234;82716;83801.58099209526;84246.57876710639;84698;10492.527836247387;10636.46817659114;10692.144628429707;10797.514111864984;10925.890741092488;15103.4713785017;15203;15206;15217.163056032025;15228.314725837365;7961.601919903982;8121.066077401057;8136.1050284468665;8231.09457959624;8253.257206851413;7766.844663106706;7812.726554570563;7854.725084622125;7939.483933544301;7954.960225198953;5993.820185394445;6257.186565746515;6552.248055816569;6556.639384833785;6641.468682505388;1942.2328180368675;1950.4343740315433;1960.3138901384402;1994.2820584589535;1999.640064788323;938.6808485115093;1085.0180586569168;1086.7828032603534;1094.8412480190327;1108.7117349489029;18970.62058758817;19101.044947752558;19994.90002549978;20122.89938550327;20213.393598192077;1041.2971244409994;1063.0379506546587;1072.5066469424153;1107.3854011023798;1118.949647265875;11049.060829829394;11382.54469821198;11484.598039068593;11509.136814738928;11515.424228788526;453690;457752;460096;461036;462849;52965.2055219172;73155;81213.59393202997;83207.58396208101;85868;1038.5015192707542;1064.084886997182;1077.7467295185781;1078.800421921947;1080.713610893114;17250.913745431193;17288.13559322004;17413.216405262046;17621.647567048843;17859.46421607354;37580.436293456165;38255.42616860694;40264.79867600643;42122;42417.575824242595;54746.726266368416;56219.15671265016;56665.716671416376;57598.136027958775;59791.10313345216;12608.621741347773;12704;13007.089503734647;13441.327933603476;13535.59393218205;14242.786358204843;14254.928725356722;14410.567682969528;14696.11823290606;14806.703865922405;12376.876231237573;12599;12989.675258118245;13022.544210952572;13417.396217170055;12311.384430778604;12421.130520863815;12478.625641230414;12795.61613151607;12979.545715899898;12465.5013799447;12601.18092323996;12856.807147892601;12941.611751647466;13105.606831795061;12468.251904885736;12968.157069790434;12971.09202355826;13001.739965200832;13008.609741707764;12642.178258413174;12750.61748147557;12826.358682066046;12901.612951611467;12916.741665166832 10:25:05 INFO - PROCESS | 16253 | |3;mootools.html;1383.605672383371;1509.2076659753632;1557.050199378379;1727.6717423689497;1861.4415675297407;8789.648414063438;9170.724878253646;9189.448633082011;9415.105564971334;9465.668701595445;9113.726588202348;9363.157315841572;9375.296852736037;9382.812343753121;9392.765180870481;1756.1219390304848;2300.160441438871;2400.543896659638;2429.514097180562;2457.103157347573;2405.1461731085474;2449.5590793657134;2450.0812195426715;2451.080844683244;2454.1901172613084;2406.5307265083316;2466.1121996081397;2469.09877894569;2469.123461171276;2470.5800013997664;1916.2047750183658;2327.9185228517003;2386.5107652931106;2391.5934291170543;2408.6146216605257;2336.7896889280046;2359.3629719975684;2368.135630494874;2371.4664200554907;2372;9085.863712044325;9186.770330741718;9208.033156518535;9210.769730756785;9213.539323033889;5330.147176451788;5443.618946673734;5449.5640348772;5464.7540860660965;5466.890662186734;3618.6381361863864;3629.564452265745;3635.709143268559;3649.8905032849057;3692.280005398948;1126.4142645824124;1151.585429245471;1159.6405114414474;1159.9304041757437;1174.0666170394557;13098.607041788762;13408.664783380493;13410.26243556604;13431.597052088453;13471.393787279498;4954.752262386866;5028.572571331405;5069.594432445396;5080.466551012164;5132.204508301219;11187.944060279646;11234.943825280821;11239;11243.943780281046;11260.718482038015;4734.786934587952;5391.595630327741;5504.174373843955;5514.448555144534;5521.972390138104;4384.386185933972;4461.152381047591;4461.687681862303;4925.187344088257;5038.319826823332;4253.914921701548;4266.530681625019;4319.546447623017;4321.049369138785;4367.344898265285;1331.094855498251;1363.4137320952086;1364.2701154882288;1367.7196174784344;1367.8700523450257;803.4897839871606;906.9093090690878;969.2924165359186;973.6981535723949;994.2791476179711;5998.640081595118;6154.292256390572;6197.194364732646;6217.9689101555105;6222;458.41552021172606;465.17895913712323;467.27105715084576;471.79691785945704;478.10355583281347;4133.937990930139;4230.64039556635;4237.724547904377;4245.830166793356;4309.439772829513;10983.505742241618;11716.297022178696;11737.178397512092;11761.941190293994;11769.411529423494;11155.776884462428;11562.94218528902;11630.6510804676;11662.416879156008;11794.941025294991;8333.458325208841;8366.832663346699;8368.3305335573;8395.370347223983;8398;5885.529157667291;5920.467157955804;5962.25471816023;5963.761449541969;6196.566240363131;9846.803063938825;10235.283530152818;10451.68644940653;10458.68623941283;10536.209784266057;10536.315139515908;10674.412907290174;10717.464126793473;10730.785384292114;10837.187210959051;7313.232110628307;7478.887816682863;7654.578998155155;8083.151269116658;8273.627686754231;8694;8705.91294087051;8742.213200811957;8780.209781119729;8786.341024423322;7810.179931107379;7895.526268423913;8131.7560473185895;8152.307053900247;8223.21879421454;7824.334931530883;7958.442908996315;8098.109207986999;8116.066652335057;8149.674013039412;7113.0753002109395;7114.750983715545;7214.603196824225;7282.344588987016;7285.453590980804;5072.721000344869;5085.059264036166;5092.618053646065;5108.361454818148;5199.66202196856;5147.768350424165;5200.167973124282;5206.297149884717;5315.880860157631;5316.840494785162 10:25:05 INFO - PROCESS | 16253 | |4;prototype.html;332.3204047722409;342.36149581031384;344.07958710449543;344.58133367957925;351.49033900843773;5272.710000949946;5328.973355133228;5331.520163185312;5353.839384818452;5416.783328666858;5264.763085661145;5290.841274761754;5314.166612518685;5325.2723093834375;5364.704941228231;3769.7738135711807;3974.443577899089;4061.1877624475073;4122.361034039714;4147.212029714345;4144.8963775905695;4150.377443383486;4166;4167.45823043004;4190.805620398187;4147.460830092084;4169.4162817205615;4186;4187.790610469479;4196.433481479991;3938.6652134568594;3955.5451123120633;4025.7181997260204;4060.309747342959;4151.086760912594;3683.594804571495;3715.925681486382;3719.6280371962857;3733.533308336458;3736.2999835074975;5000.849974500771;5001.424836143818;5010.599152067826;5016.8176843073015;5114.616403769732;4518.164139634178;4731.243001119804;4746.715197088186;4776.546228108324;4811.831585894477;5465.9180112298345;5472.151816468454;5484.681767530667;5505.944940550623;5515.338159420855;3980.5223373195113;4025.8590949316927;4027.7583344999393;4029.073313137995;4037;5452.890942181134;5717.742701578439;5726.4273572642405;5800.53595712342;5808.2449281593545;4112.979435102805;4126.596957034622;4141.233871733739;4146.896327591774;4158.9376159357635;4138.089620283533;4143.37849322598;4149.647279981175;4160.375943608423;4203.054312779661;4514.887127821765;4699.6240300776535;4707.270373092176;4735.621150307967;4749.857504274808;5460.208269800856;5508;5542.0928245586765;5569.582281328917;5584.190292407578;1391.4573316406406;1396.7206558688304;1399.5661344983089;1406.9648258793611;1417.4967886400386;894.7339514586787;902.0573500691793;903;931.7111695374456;953.2374100719535;4666.533346665374;4766.594839438617;4772.785224664898;4789.185838407479;4801.831935882227;5030.622703297267;5054.2671312660195;5059;5071.873203169876;5084.8220312288895;4530.343100250511;4726.665075196942;4741.786619602126;4780.665353425296;4807.879803004953;2716.511028014976;2720.836749794979;2724.501524161703;2735.5623100304256;2787.6097346371525;5232.136697444879;5233.267342572043;5249.317588713519;5249.873801110556;5255.159174532133;4938.728369939616;5127.461616530285;5128.410232823273;5173.793048278027;5178.741062946838;5121.769520371592;5172.844814655567;5201.375834899836;5217.243499692523;5240.069947539346;5019.974900125476;5032.986805277918;5058.964621227381;5088.771005304844;5102.4642412546145;4947.950520494749;5022.397312322545;5229.843104706712;5711;5714.285714285715;5873.9412605873395;5931.635723783467;5959.940400596112;5972.193753843176;5978.611390259619;4018.1762738639095;4025.3835007245525;4034.9193016138925;4041.85853495138;4049.1901619675596;5467.289252397163;5667.829965101054;5671.262735844314;5730.971345143247;5737.397573254748;5526.47498487643;5531.2532808072;5591.524720398812;5594.636348637326;5605.730613223557;5299.894002120013;5512.924979628934;5533.806316778893;5582.944170558405;5660.320761508646;5461.1262198048125;5464.098423760035;5476.64606637732;5476.726163691879;5499.697516636464;5566.777328906798;5599.412061733459;5605.971970140124;5615.803446879339;5644.85887852807;5210.53105220532;5426.647267927572;5442.156465747816;5518.862028449321;5523.502884740393 10:25:05 INFO - PROCESS | 16253 | |5;yui.html;839.8152406470576;856.5374697663262;859.7592674051268;871.6121326009924;883.1389395339545;13057.869421305795;14116.294185290746;14150.50473233437;14202.07686500378;14276.785848212272;14222.71554568908;14257.215853128073;14293.78559321611;14319;14342.06776559523;687.1753895325604;706.2125729811249;706.4913262451028;832.592029905345;844.1389782421926;704.1128178495081;813.8616435206029;845.0577605969331;846.0524212881581;846.1876598465481;889.2752406788479;893.3880292000001;894.9910500895005;895.4492986813128;895.5880295064246;736.6648175080326;891.9108089191094;893.196123488862;893.2005854759985;893.6068130022802;631.9178506794133;640.478010421505;643.3598569423453;645.6416688737748;647.3882181338637;13228.074034817566;13256.933715331457;13288.601341959757;13335.73328533424;13428.664283392896;12923.87076129236;13506.86493135066;13542.661433464144;13557.728845423135;13758.65603359914;11827.34949577773;12101.273923564615;12111.273323600612;12152;12316.322602256872;4444;4532.628478197252;4537.591616754475;4545.863624091283;4551.463925489106;53513.73243133799;54249.45750542523;56280.71859640717;56537.15194272089;56768.14847777328;11251.268667536584;11301.830472542919;11356.48895799691;11382.373969431595;11389.829152562717;19943.301984430476;19963.700544491843;19972.90013549923;19988.300409485597;20001.499962501053;8176.959115204505;8293.170682931779;8366.37252206087;8373.665053397795;8617.655293788304;4709.858704238878;4791.808327666924;4902.8774280643265;4921.557059864629;4996.650234483552;3324.7173990210617;3399.7790143640586;3409.1136304560496;3413.317336532654;3414.8804791832167;617.2315467243311;624.7719582352499;631.3024108360196;636.226984214182;648.1412128929188;555.8193587084133;609.0926705186181;614.7888659341091;637.171676820132;659.3472462262325;9655.468949207721;9789.21686265097;9803.411795292306;9846.704598862045;9883.11052005323;644.7002144003061;677.522346745553;714.5319815520842;719.4747834081151;748.1060133140844;4514.774261286922;4516.593506584423;4674.345591617176;4730.95269047312;4806.375171227718;60501.69749151226;61613;61835.690821545606;69294.65352673204;71903.64048179725;59655.70172149198;59798.402015979285;59933.70033149806;63568;63759;57038.714806426535;57437.42562574404;57600.42399576034;57625.42374576285;58470.99999999915;9750.756231093996;9815.214782817215;9890.307678462439;9913.752156196153;9992.150667193078;37508.43737343887;37747.43378849374;37876.81061594674;37930.241395172496;38210.235795283385;43638;46255.76872115618;48822.755886220344;49648.751756240985;50040;12470.56353027676;12507.687307817014;12706.428210730724;12721.745297288631;12861.164024338388;13641.727165456437;13880.51418200358;13936.721265574835;14840;14846.77729834075;12867.292298923649;12946.741065178832;13311.733765324445;13653.658658533615;13717.45130194781;12965.546205882749;12973.286469243905;13568.1859088455;13621.922750950342;14124.364403601658;12508.562200322946;13269.933650331686;13333.933330333286;13519.459221631025;13713.314334283046;11212.27120237182;11256.943715281372;11261.793334429847;11273.267237629529;11549.94225028903;10562.577496900038;11250.156238281998;11313.434328283718;11315.603953861575;11424.257423267461 10:25:05 INFO - PROCESS | 16253 | __end_tp_report 10:25:05 INFO - PROCESS | 16253 | __start_cc_report 10:25:05 INFO - PROCESS | 16253 | _x_x_mozilla_cycle_collect,823 10:25:05 INFO - PROCESS | 16253 | __end_cc_report 10:25:05 INFO - PROCESS | 16253 | __startTimestamp1463073905761__endTimestamp 10:25:05 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | ------- Summary: start ------- 10:25:05 INFO - PROCESS | 16253 | Number of tests: 6 10:25:05 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | [#0] dojo.html Cycles:165 Average:5401.97 Median:5592.61 stddev:611.59 (10.9%) stddev-sans-first:588.29 10:25:05 INFO - PROCESS | 16253 | Values: 3188.1 3193.5 3220.9 3224.4 3249.5 5240.4 5312.7 5316.5 5403.6 5445.4 5306.5 5344.2 5381.2 5417.5 5426.9 4870.6 4945.9 4979.4 4982.3 5123.7 4984.5 5017.2 5045.1 5055.3 5070.3 4780.1 4838.0 4855.2 4937.6 4957.6 4862.7 4914.9 4992.3 4995.7 5029.5 4813.7 4943.0 4957.5 4957.9 4961.1 5259.9 5328.4 5351.2 5391.0 5395.4 5813.8 5824.3 5829.9 5857.6 5859.0 5687.1 5797.8 5872.4 5897.4 5941.3 5447.1 5530.1 5538.6 5539.6 5545.5 6005.2 6005.8 6039.8 6050.9 6064.7 5530.2 5650.9 5684.8 5817.5 5827.8 5789.3 5797.0 5802.0 5819.9 5860.2 5724.3 5754.2 5771.3 5776.1 5809.1 5602.8 5752.5 5790.8 5802.6 5814.9 4407.5 4411.2 4413.4 4414.6 4453.2 3953.9 3966.6 3978.5 4005.1 4019.2 5321.9 5433.9 5456.6 5515.8 5517.1 5867.2 5873.6 5877.1 5892.9 5895.8 5544.7 5558.2 5560.2 5573.1 5575.3 4849.6 4937.6 4951.5 4977.7 5006.5 6007.2 6026.3 6040.8 6045.5 6050.7 5650.0 5836.4 5854.6 5865.1 5865.2 5996.7 6033.2 6055.1 6084.6 6092.1 5741.7 5784.4 5788.4 5788.7 5797.4 5644.4 5768.2 5891.9 5899.6 5900.3 5636.7 5673.0 5674.2 5694.9 5730.6 5623.7 5674.1 5686.7 5690.3 5701.4 5400.8 5510.5 5526.1 5592.6 5599.2 5702.7 5722.8 5732.8 5743.2 5744.6 5555.1 5582.5 5586.8 5603.7 5624.2 10:25:05 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | [#1] ext.html Cycles:180 Average:57633.15 Median:22806.52 stddev:108529.81 (475.9%) stddev-sans-first:108749.82 10:25:05 INFO - PROCESS | 16253 | Values: 612.0 646.4 650.8 658.9 668.6 34050.5 36974.4 37098.6 37120.6 44731.0 42206.4 46103.5 46110.0 46119.5 46120.3 8940.6 9090.8 9099.3 9106.2 9109.9 8920.2 8984.6 9016.8 9023.1 9025.2 8874.2 8907.3 8909.8 8910.5 8914.0 9032.6 9060.4 9069.9 9074.8 9080.9 8932.2 8979.6 8997.1 8998.7 8999.9 43019.8 43226.8 43256.6 43258.6 43317.4 3476.6 3583.7 3583.9 3602.3 3605.4 32065.2 32231.8 32375.4 32610.8 33285.0 4015.0 4022.1 4029.4 4097.4 4170.2 326618.0 326676.0 327051.0 327072.0 327706.0 61546.4 61736.4 61895.0 62168.4 62315.7 37555.8 38060.8 38130.8 65896.3 66024.7 16307.3 16330.9 16365.2 16388.6 16396.3 13685.4 13803.9 13812.6 13818.3 13827.2 20623.9 20816.0 20821.5 20833.5 20857.6 7492.4 7524.8 7570.9 7603.0 7837.2 1014.6 1094.0 1130.7 1137.3 1194.4 32980.3 33341.2 33604.7 33788.0 34029.3 1156.6 1172.3 1173.3 1198.6 1302.1 17941.6 17995.9 18038.0 18119.7 18249.4 492065.0 492509.0 496033.0 496984.0 498550.0 61640.4 62264.0 62405.0 62609.0 62659.4 1320.7 1392.5 1428.9 1431.9 1451.4 33090.5 34487.8 34976.7 35233.6 35347.5 52745.5 52763.0 52903.0 52985.5 53007.0 389762.0 393453.0 393703.0 394031.0 394483.0 26504.0 28509.9 29480.0 29481.1 30453.7 48759.3 49719.3 50056.2 50411.0 50597.0 41515.6 41701.4 41824.2 42749.1 43023.6 41708.6 41811.6 42134.2 42226.0 42681.0 41809.4 41847.2 42862.6 42936.0 43031.8 34548.8 36781.4 36886.3 37199.4 37258.8 28820.6 29085.9 30587.5 31214.0 31439.5 10:25:05 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | [#2] jquery.html Cycles:180 Average:28225.66 Median:10997.27 stddev:75452.39 (686.1%) stddev-sans-first:75635.15 10:25:05 INFO - PROCESS | 16253 | Values: 411.7 416.3 417.6 419.1 425.5 14065.5 18472.1 19004.5 19079.2 20183.7 14755.5 18235.2 18358.7 18758.6 19571.2 5668.8 5715.6 5726.2 5742.4 5897.8 5734.3 5806.2 5838.9 5839.5 5854.9 4078.2 6108.8 6359.6 6421.0 6525.1 6432.5 6476.8 6502.8 6510.5 6523.4 5634.9 5697.0 5725.2 5787.6 5789.4 22664.5 22910.7 23103.7 23157.1 23189.4 2305.3 2317.9 2355.4 2387.8 2415.9 13126.2 14380.1 14442.1 14580.0 14890.5 1986.3 2014.2 2050.7 2071.5 2090.9 80508.6 82716.0 83801.6 84246.6 84698.0 10492.5 10636.5 10692.1 10797.5 10925.9 15103.5 15203.0 15206.0 15217.2 15228.3 7961.6 8121.1 8136.1 8231.1 8253.3 7766.8 7812.7 7854.7 7939.5 7955.0 5993.8 6257.2 6552.2 6556.6 6641.5 1942.2 1950.4 1960.3 1994.3 1999.6 938.7 1085.0 1086.8 1094.8 1108.7 18970.6 19101.0 19994.9 20122.9 20213.4 1041.3 1063.0 1072.5 1107.4 1118.9 11049.1 11382.5 11484.6 11509.1 11515.4 453690.0 457752.0 460096.0 461036.0 462849.0 52965.2 73155.0 81213.6 83207.6 85868.0 1038.5 1064.1 1077.7 1078.8 1080.7 17250.9 17288.1 17413.2 17621.6 17859.5 37580.4 38255.4 40264.8 42122.0 42417.6 54746.7 56219.2 56665.7 57598.1 59791.1 12608.6 12704.0 13007.1 13441.3 13535.6 14242.8 14254.9 14410.6 14696.1 14806.7 12376.9 12599.0 12989.7 13022.5 13417.4 12311.4 12421.1 12478.6 12795.6 12979.5 12465.5 12601.2 12856.8 12941.6 13105.6 12468.3 12968.2 12971.1 13001.7 13008.6 12642.2 12750.6 12826.4 12901.6 12916.7 10:25:05 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | [#3] mootools.html Cycles:180 Average:6030.53 Median:2603.29 stddev:3529.18 (135.6%) stddev-sans-first:3521.80 10:25:05 INFO - PROCESS | 16253 | Values: 1383.6 1509.2 1557.1 1727.7 1861.4 8789.6 9170.7 9189.4 9415.1 9465.7 9113.7 9363.2 9375.3 9382.8 9392.8 1756.1 2300.2 2400.5 2429.5 2457.1 2405.1 2449.6 2450.1 2451.1 2454.2 2406.5 2466.1 2469.1 2469.1 2470.6 1916.2 2327.9 2386.5 2391.6 2408.6 2336.8 2359.4 2368.1 2371.5 2372.0 9085.9 9186.8 9208.0 9210.8 9213.5 5330.1 5443.6 5449.6 5464.8 5466.9 3618.6 3629.6 3635.7 3649.9 3692.3 1126.4 1151.6 1159.6 1159.9 1174.1 13098.6 13408.7 13410.3 13431.6 13471.4 4954.8 5028.6 5069.6 5080.5 5132.2 11187.9 11234.9 11239.0 11243.9 11260.7 4734.8 5391.6 5504.2 5514.4 5522.0 4384.4 4461.2 4461.7 4925.2 5038.3 4253.9 4266.5 4319.5 4321.0 4367.3 1331.1 1363.4 1364.3 1367.7 1367.9 803.5 906.9 969.3 973.7 994.3 5998.6 6154.3 6197.2 6218.0 6222.0 458.4 465.2 467.3 471.8 478.1 4133.9 4230.6 4237.7 4245.8 4309.4 10983.5 11716.3 11737.2 11761.9 11769.4 11155.8 11562.9 11630.7 11662.4 11794.9 8333.5 8366.8 8368.3 8395.4 8398.0 5885.5 5920.5 5962.3 5963.8 6196.6 9846.8 10235.3 10451.7 10458.7 10536.2 10536.3 10674.4 10717.5 10730.8 10837.2 7313.2 7478.9 7654.6 8083.2 8273.6 8694.0 8705.9 8742.2 8780.2 8786.3 7810.2 7895.5 8131.8 8152.3 8223.2 7824.3 7958.4 8098.1 8116.1 8149.7 7113.1 7114.8 7214.6 7282.3 7285.5 5072.7 5085.1 5092.6 5108.4 5199.7 5147.8 5200.2 5206.3 5315.9 5316.8 10:25:05 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | [#4] prototype.html Cycles:180 Average:4536.45 Median:5056.62 stddev:1312.46 (26.0%) stddev-sans-first:1277.65 10:25:05 INFO - PROCESS | 16253 | Values: 332.3 342.4 344.1 344.6 351.5 5272.7 5329.0 5331.5 5353.8 5416.8 5264.8 5290.8 5314.2 5325.3 5364.7 3769.8 3974.4 4061.2 4122.4 4147.2 4144.9 4150.4 4166.0 4167.5 4190.8 4147.5 4169.4 4186.0 4187.8 4196.4 3938.7 3955.5 4025.7 4060.3 4151.1 3683.6 3715.9 3719.6 3733.5 3736.3 5000.8 5001.4 5010.6 5016.8 5114.6 4518.2 4731.2 4746.7 4776.5 4811.8 5465.9 5472.2 5484.7 5505.9 5515.3 3980.5 4025.9 4027.8 4029.1 4037.0 5452.9 5717.7 5726.4 5800.5 5808.2 4113.0 4126.6 4141.2 4146.9 4158.9 4138.1 4143.4 4149.6 4160.4 4203.1 4514.9 4699.6 4707.3 4735.6 4749.9 5460.2 5508.0 5542.1 5569.6 5584.2 1391.5 1396.7 1399.6 1407.0 1417.5 894.7 902.1 903.0 931.7 953.2 4666.5 4766.6 4772.8 4789.2 4801.8 5030.6 5054.3 5059.0 5071.9 5084.8 4530.3 4726.7 4741.8 4780.7 4807.9 2716.5 2720.8 2724.5 2735.6 2787.6 5232.1 5233.3 5249.3 5249.9 5255.2 4938.7 5127.5 5128.4 5173.8 5178.7 5121.8 5172.8 5201.4 5217.2 5240.1 5020.0 5033.0 5059.0 5088.8 5102.5 4948.0 5022.4 5229.8 5711.0 5714.3 5873.9 5931.6 5959.9 5972.2 5978.6 4018.2 4025.4 4034.9 4041.9 4049.2 5467.3 5667.8 5671.3 5731.0 5737.4 5526.5 5531.3 5591.5 5594.6 5605.7 5299.9 5512.9 5533.8 5582.9 5660.3 5461.1 5464.1 5476.6 5476.7 5499.7 5566.8 5599.4 5606.0 5615.8 5644.9 5210.5 5426.6 5442.2 5518.9 5523.5 10:25:05 INFO - PROCESS | 16253 | 10:25:05 INFO - PROCESS | 16253 | [#5] yui.html Cycles:180 Average:15696.07 Median:4720.41 stddev:18451.37 (390.9%) stddev-sans-first:18469.40 10:25:05 INFO - PROCESS | 16253 | Values: 839.8 856.5 859.8 871.6 883.1 13057.9 14116.3 14150.5 14202.1 14276.8 14222.7 14257.2 14293.8 14319.0 14342.1 687.2 706.2 706.5 832.6 844.1 704.1 813.9 845.1 846.1 846.2 889.3 893.4 895.0 895.4 895.6 736.7 891.9 893.2 893.2 893.6 631.9 640.5 643.4 645.6 647.4 13228.1 13256.9 13288.6 13335.7 13428.7 12923.9 13506.9 13542.7 13557.7 13758.7 11827.3 12101.3 12111.3 12152.0 12316.3 4444.0 4532.6 4537.6 4545.9 4551.5 53513.7 54249.5 56280.7 56537.2 56768.1 11251.3 11301.8 11356.5 11382.4 11389.8 19943.3 19963.7 19972.9 19988.3 20001.5 8177.0 8293.2 8366.4 8373.7 8617.7 4709.9 4791.8 4902.9 4921.6 4996.7 3324.7 3399.8 3409.1 3413.3 3414.9 617.2 624.8 631.3 636.2 648.1 555.8 609.1 614.8 637.2 659.3 9655.5 9789.2 9803.4 9846.7 9883.1 644.7 677.5 714.5 719.5 748.1 4514.8 4516.6 4674.3 4731.0 4806.4 60501.7 61613.0 61835.7 69294.7 71903.6 59655.7 59798.4 59933.7 63568.0 63759.0 57038.7 57437.4 57600.4 57625.4 58471.0 9750.8 9815.2 9890.3 9913.8 9992.2 37508.4 37747.4 37876.8 37930.2 38210.2 43638.0 46255.8 48822.8 49648.8 50040.0 12470.6 12507.7 12706.4 12721.7 12861.2 13641.7 13880.5 13936.7 14840.0 14846.8 12867.3 12946.7 13311.7 13653.7 13717.5 12965.5 12973.3 13568.2 13621.9 14124.4 12508.6 13269.9 13333.9 13519.5 13713.3 11212.3 11256.9 11261.8 11273.3 11549.9 10562.6 11250.2 11313.4 11315.6 11424.3 10:25:05 INFO - PROCESS | 16253 | -------- Summary: end -------- 10:25:05 INFO - PROCESS | 16253 | 10:25:06 INFO - TEST-INFO | 16253: exit 0 10:25:06 INFO - TEST-OK | dromaeo_css | took 1112262ms 10:25:06 INFO - TEST-START | kraken 10:25:06 INFO - operating with platform_type : linux_ 10:25:06 INFO - Initialising browser for kraken test... 10:25:06 INFO - TEST-INFO | started process 16441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoOWskw/profile http://localhost:54714/getInfo.html) 10:25:10 INFO - PROCESS | 16441 | __metrics Screen width/height:1600/1200 10:25:10 INFO - PROCESS | 16441 | colorDepth:24 10:25:10 INFO - PROCESS | 16441 | Browser inner width/height: 1024/697 10:25:10 INFO - PROCESS | 16441 | __metrics 10:25:11 ERROR - PROCESS | 16441 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:25:12 INFO - TEST-INFO | 16441: exit 0 10:25:12 INFO - Browser initialized. 10:25:12 INFO - Running cycle 1/1 for kraken test... 10:25:12 INFO - TEST-INFO | started process 16521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoOWskw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:24 INFO - PROCESS | 16521 | RSS: Main: 152780800 10:25:24 INFO - PROCESS | 16521 | 10:25:26 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54714/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:27 INFO - PROCESS | 16521 | RSS: Main: 208510976 10:25:27 INFO - PROCESS | 16521 | 10:25:30 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54714/tests/kraken/driver.html?testName=audio-dft) 10:25:30 INFO - PROCESS | 16521 | RSS: Main: 197578752 10:25:30 INFO - PROCESS | 16521 | 10:25:34 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54714/tests/kraken/driver.html?testName=audio-fft) 10:25:34 INFO - PROCESS | 16521 | RSS: Main: 264974336 10:25:34 INFO - PROCESS | 16521 | 10:25:36 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54714/tests/kraken/driver.html?testName=audio-oscillator) 10:25:37 INFO - PROCESS | 16521 | RSS: Main: 174653440 10:25:37 INFO - PROCESS | 16521 | 10:25:39 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:40 INFO - PROCESS | 16521 | RSS: Main: 178704384 10:25:40 INFO - PROCESS | 16521 | 10:25:43 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54714/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:44 INFO - PROCESS | 16521 | RSS: Main: 214704128 10:25:44 INFO - PROCESS | 16521 | 10:25:47 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54714/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:48 INFO - PROCESS | 16521 | RSS: Main: 213073920 10:25:48 INFO - PROCESS | 16521 | 10:25:51 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54714/tests/kraken/driver.html?testName=json-parse-financial) 10:25:51 INFO - PROCESS | 16521 | RSS: Main: 213909504 10:25:51 INFO - PROCESS | 16521 | 10:25:53 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:53 INFO - PROCESS | 16521 | RSS: Main: 202018816 10:25:53 INFO - PROCESS | 16521 | 10:25:55 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:56 INFO - PROCESS | 16521 | RSS: Main: 206979072 10:25:56 INFO - PROCESS | 16521 | 10:25:58 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:59 INFO - PROCESS | 16521 | RSS: Main: 217305088 10:25:59 INFO - PROCESS | 16521 | 10:26:01 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:02 INFO - PROCESS | 16521 | RSS: Main: 223281152 10:26:02 INFO - PROCESS | 16521 | 10:26:05 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:05 INFO - PROCESS | 16521 | RSS: Main: 217718784 10:26:05 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54714/tests/kraken/driver.html?testName=ai-astar) 10:26:07 INFO - PROCESS | 16521 | RSS: Main: 263127040 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | __start_tp_report 10:26:07 INFO - PROCESS | 16521 | _x_x_mozilla_page_load 10:26:07 INFO - PROCESS | 16521 | _x_x_mozilla_page_load_details 10:26:07 INFO - PROCESS | 16521 | |i|pagename|runs| 10:26:07 INFO - PROCESS | 16521 | |0;ai-astar;110;105;110;109;109;110;109;109;109;108 10:26:07 INFO - PROCESS | 16521 | |1;audio-beat-detection;153;125;157;221;130;156;149;126;189;123 10:26:07 INFO - PROCESS | 16521 | |2;audio-dft;162;160;161;161;162;162;161;160;160;160 10:26:07 INFO - PROCESS | 16521 | |3;audio-fft;73;74;76;156;76;75;75;74;126;74 10:26:07 INFO - PROCESS | 16521 | |4;audio-oscillator;91;92;148;93;91;91;123;92;93;121 10:26:07 INFO - PROCESS | 16521 | |5;imaging-gaussian-blur;117;116;117;116;117;117;116;116;116;116 10:26:07 INFO - PROCESS | 16521 | |6;imaging-darkroom;145;146;146;146;146;147;145;146;145;145 10:26:07 INFO - PROCESS | 16521 | |7;imaging-desaturate;95;95;96;96;96;96;95;95;95;95 10:26:07 INFO - PROCESS | 16521 | |8;json-parse-financial;53;54;53;54;55;54;53;106;52;52 10:26:07 INFO - PROCESS | 16521 | |9;json-stringify-tinderbox;60;59;59;59;59;59;59;59;59;60 10:26:07 INFO - PROCESS | 16521 | |10;stanford-crypto-aes;79;79;78;78;78;84;79;79;80;80 10:26:07 INFO - PROCESS | 16521 | |11;stanford-crypto-ccm;121;128;128;126;118;128;127;118;191;124 10:26:07 INFO - PROCESS | 16521 | |12;stanford-crypto-pbkdf2;161;171;160;165;161;157;160;158;158;160 10:26:07 INFO - PROCESS | 16521 | |13;stanford-crypto-sha256-iterative;63;63;62;61;64;62;62;62;65;69 10:26:07 INFO - PROCESS | 16521 | __end_tp_report 10:26:07 INFO - PROCESS | 16521 | __start_cc_report 10:26:07 INFO - PROCESS | 16521 | _x_x_mozilla_cycle_collect,1821 10:26:07 INFO - PROCESS | 16521 | __end_cc_report 10:26:07 INFO - PROCESS | 16521 | __startTimestamp1463073967713__endTimestamp 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | ------- Summary: start ------- 10:26:07 INFO - PROCESS | 16521 | Number of tests: 14 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:1.48 (1.4%) stddev-sans-first:1.50 10:26:07 INFO - PROCESS | 16521 | Values: 110.0 105.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 108.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:154.50 stddev:31.45 (20.4%) stddev-sans-first:33.36 10:26:07 INFO - PROCESS | 16521 | Values: 153.0 125.0 157.0 221.0 130.0 156.0 149.0 126.0 189.0 123.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 10:26:07 INFO - PROCESS | 16521 | Values: 162.0 160.0 161.0 161.0 162.0 162.0 161.0 160.0 160.0 160.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#3] audio-fft Cycles:10 Average:87.90 Median:74.50 stddev:28.88 (38.8%) stddev-sans-first:30.13 10:26:07 INFO - PROCESS | 16521 | Values: 73.0 74.0 76.0 156.0 76.0 75.0 75.0 74.0 126.0 74.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:91.50 stddev:20.06 (21.9%) stddev-sans-first:20.76 10:26:07 INFO - PROCESS | 16521 | Values: 91.0 92.0 148.0 93.0 91.0 91.0 123.0 92.0 93.0 121.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:26:07 INFO - PROCESS | 16521 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 116.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 10:26:07 INFO - PROCESS | 16521 | Values: 145.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 145.0 145.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:26:07 INFO - PROCESS | 16521 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:53.50 stddev:16.68 (31.2%) stddev-sans-first:17.57 10:26:07 INFO - PROCESS | 16521 | Values: 53.0 54.0 53.0 54.0 55.0 54.0 53.0 106.0 52.0 52.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 10:26:07 INFO - PROCESS | 16521 | Values: 60.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:1.78 (2.2%) stddev-sans-first:1.88 10:26:07 INFO - PROCESS | 16521 | Values: 79.0 79.0 78.0 78.0 78.0 84.0 79.0 79.0 80.0 80.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:127.50 stddev:21.49 (16.9%) stddev-sans-first:22.49 10:26:07 INFO - PROCESS | 16521 | Values: 121.0 128.0 128.0 126.0 118.0 128.0 127.0 118.0 191.0 124.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:160.50 stddev:4.12 (2.6%) stddev-sans-first:4.37 10:26:07 INFO - PROCESS | 16521 | Values: 161.0 171.0 160.0 165.0 161.0 157.0 160.0 158.0 158.0 160.0 10:26:07 INFO - PROCESS | 16521 | 10:26:07 INFO - PROCESS | 16521 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:2.31 (3.7%) stddev-sans-first:2.45 10:26:07 INFO - PROCESS | 16521 | Values: 63.0 63.0 62.0 61.0 64.0 62.0 62.0 62.0 65.0 69.0 10:26:07 INFO - PROCESS | 16521 | -------- Summary: end -------- 10:26:07 INFO - PROCESS | 16521 | 10:26:08 INFO - TEST-INFO | 16521: exit 0 10:26:08 INFO - TEST-OK | kraken | took 62168ms 10:26:08 INFO - SUITE-END | took 1174s 10:26:08 INFO - Completed test suite (00:19:34) 10:26:08 INFO - javascript benchmark 10:26:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.1073299476147, 3193.505006723957, 3220.871165153394, 3224.371247606715, 3249.5450636910823, 5240.423553409122, 5312.73436328183, 5316.494932981365, 5403.567714582834, 5445.428230035844, 5306.4958828911285, 5344.198370244456, 5381.165919282507, 5417.51242388185, 5426.945730542693, 4870.634702397326, 4945.901081978358, 4979.427365852919, 4982.277569752384, 5123.718195499246, 4984.451710311862, 5017.19724844025, 5045.066662667418, 5055.266986287004, 5070.264811602334, 4780.067886762065, 4838.03239352131, 4855.247436647308, 4937.580305674022, 4957.628177886637, 4862.7325497097645, 4914.90170196594, 4992.251162325644, 4995.675281106716, 5029.497050294978, 4813.687110337817, 4943.036107958949, 4957.529034741694, 4957.851264462072, 4961.131801934647, 5259.868503287448, 5328.360596728378, 5351.170568561879, 5391.002664507039, 5395.433479484637, 5813.79651712188, 5824.271966004249, 5829.921464529033, 5857.560682948753, 5858.970705146489, 5687.061634830289, 5797.768089276424, 5872.412758724136, 5897.380775018647, 5941.257342832146, 5447.073997420408, 5530.115181570929, 5538.584606154554, 5539.584531160179, 5545.528630066449, 6005.159277701038, 6005.789797357072, 6039.849003774941, 6050.9394906050375, 6064.696765161724, 5530.170474428787, 5650.85872853182, 5684.772609095672, 5817.50551203144, 5827.79602713903, 5789.305283366023, 5797.0, 5802.0426629605645, 5819.941800582024, 5860.238169037998, 5724.313082430135, 5754.165645981309, 5771.307443106854, 5776.075827867521, 5809.070548712186, 5602.803901863415, 5752.539796816244, 5790.826275211666, 5802.593818432669, 5814.912776308359, 4407.493138289074, 4411.1618792429335, 4413.404190434315, 4414.646828253732, 4453.1761624099, 3953.9011524711536, 3966.5835087315995, 3978.542467616261, 4005.118873847749, 4019.2162528307285, 5321.946780532146, 5433.918491222635, 5456.563474921997, 5515.751791169407, 5517.089680202722, 5867.178594996704, 5873.647581145145, 5877.059670452707, 5892.941070589325, 5895.764169433174, 5544.695041772741, 5558.249636299129, 5560.2493663355735, 5573.108302671553, 5575.275214222206, 4849.636277279218, 4937.604991600663, 4951.455339912607, 4977.726225057657, 5006.4743201964, 6007.219061521974, 6026.337102918676, 6040.7583696651645, 6045.486133678686, 6050.7277172526465, 5649.971750141223, 5836.387179346192, 5854.590178687451, 5865.14955331466, 5865.178874957424, 5996.67018313997, 6033.18551995475, 6055.122007308827, 6084.6349219047, 6092.086187071975, 5741.712914354349, 5784.392638772868, 5788.421157884178, 5788.739506722123, 5797.391273916178, 5644.407337229696, 5768.221290125947, 5891.852703682443, 5899.557533184942, 5900.291964964232, 5636.746346414503, 5673.0, 5674.177244299636, 5694.914576281276, 5730.5702072345575, 5623.690697011703, 5674.092145256739, 5686.687232202268, 5690.2887139107615, 5701.372848986691, 5400.756965936621, 5510.531604813636, 5526.143447765603, 5592.608517403743, 5599.216109744721, 5702.743376548148, 5722.7710891563875, 5732.799352022659, 5743.195952566728, 5744.569157313302, 5555.138953462219, 5582.469665381782, 5586.832395028156, 5603.663780173202, 5624.156376543551], "value": 5361.40639091794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.95716299859, 646.4149944300408, 650.7754824585517, 658.8550518885844, 668.595499722668, 34050.48924266135, 36974.44538331924, 37098.629013709855, 37120.62879371206, 44731.0, 42206.366904496455, 46103.53896461034, 46110.0, 46119.53880461194, 46120.30819537701, 8940.64237430502, 9090.77273068172, 9099.317551183654, 9106.225970792491, 9109.908900911005, 8920.241779448756, 8984.550772461384, 9016.77458063547, 9023.142801433885, 9025.18773310402, 8874.245689116433, 8907.331950103768, 8909.777255568597, 8910.465372077664, 8914.0, 9032.593533291018, 9060.411073280216, 9069.863952040725, 9074.820273364421, 9080.909190908073, 8932.15144561272, 8979.595918183697, 8997.145271199226, 8998.730038098867, 8999.910000900038, 43019.78490107561, 43226.78386608047, 43256.56743432588, 43258.56741432577, 43317.35023974643, 3476.5654293213347, 3583.6774690278, 3583.8924832254816, 3602.2615363850346, 3605.369060414417, 32065.198370040704, 32231.83884080588, 32375.352492950246, 32610.836945815357, 33285.0, 4014.959850401488, 4022.1352409232154, 4029.4157347184787, 4097.44684467596, 4170.22850772608, 326618.0, 326676.0, 327051.0, 327072.0, 327706.0, 61546.38453615496, 61736.38263617306, 61895.0, 62168.37831621626, 62315.6884215576, 37555.81222093872, 38060.80969595134, 38130.80934595365, 65896.34103658902, 66024.66987665031, 16307.266173022243, 16330.918345408198, 16365.181740912907, 16388.590285242964, 16396.26216820246, 13685.384157712926, 13803.861961380258, 13812.585622431143, 13818.309084545934, 13827.239501827496, 20623.896880515502, 20816.0, 20821.479463013548, 20833.479163020744, 20857.582848342947, 7492.400607951351, 7524.833650784137, 7570.886436703454, 7603.0, 7837.177096404909, 1014.5992333028413, 1093.9781204376027, 1130.6777568392968, 1137.2550979108696, 1194.4147367789722, 32980.340393192004, 33341.16647083842, 33604.66395336064, 33788.0052581335, 34029.31941361159, 1156.5605070073486, 1172.261475270574, 1173.3194747046693, 1198.6404078776332, 1302.101549930545, 17941.551461213574, 17995.910020450076, 18038.0, 18119.72820407695, 18249.36127235567, 492065.0, 492509.0, 496033.0, 496984.0, 498550.0, 61640.38359616436, 62264.0, 62405.0, 62609.0, 62659.37340626535, 1320.7028418605737, 1392.5126205828083, 1428.8714015738633, 1431.9069260498034, 1451.3614009835849, 33090.5036424449, 34487.7582957107, 34976.65023349836, 35233.64766352406, 35347.46978795269, 52745.47254527405, 52763.0, 52903.0, 52985.47014529805, 53007.0, 389762.0, 393453.0, 393703.0, 394031.0, 394483.0, 26504.0, 28509.857450712614, 29480.0, 29481.115566533037, 30453.695463045085, 48759.26861097015, 49719.25421118614, 50056.249156261954, 50411.0, 50597.0, 41515.58484415238, 41701.37447938344, 41824.16351673011, 42749.14501709886, 43023.56976430321, 41708.58291417168, 41811.581884181986, 42134.15731685288, 42226.0, 42681.0, 41809.37285940774, 41847.1630567393, 42862.57137428711, 42936.0, 43031.7848410756, 34548.82725586356, 36781.44827827531, 36886.26227475489, 37199.442008369355, 37258.813705931294, 28820.558972051735, 29085.85457072701, 30587.54118688177, 31214.0, 31439.52840707437], "value": 20422.0015730785, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.7138588680866, 416.3297091682391, 417.6450017485138, 419.1198483185313, 425.50216246991016, 14065.507707230223, 18472.076396180204, 19004.524886877836, 19079.23683052678, 20183.69724454131, 14755.48355807547, 18235.179416926236, 18358.72461913069, 18758.62482750344, 19571.21715131393, 5668.829935101953, 5715.628484148517, 5726.226959360495, 5742.39704830993, 5897.793577224798, 5734.311882574097, 5806.187133801272, 5838.854028649275, 5839.474447299742, 5854.912176317359, 4078.163976384849, 6108.755649774003, 6359.586626869239, 6421.0, 6525.086487891699, 6432.517561182884, 6476.773312934049, 6502.804915852508, 6510.511711621623, 6523.412892839619, 5634.943650563483, 5697.031504644179, 5725.227094342252, 5787.623804452697, 5789.392113828072, 22664.546709065726, 22910.65634015491, 23103.653445198335, 23157.0737170513, 23189.420264493354, 2305.342977251475, 2317.9072837086665, 2355.387599224197, 2387.8089752819733, 2415.903363865443, 13126.2124272543, 14380.137191768526, 14442.133471991714, 14580.0, 14890.478833240893, 1986.3147214211074, 2014.2345908554803, 2050.733404657385, 2071.533904871407, 2090.937271881846, 80508.59745701234, 82716.0, 83801.58099209526, 84246.57876710639, 84698.0, 10492.527836247387, 10636.46817659114, 10692.144628429707, 10797.514111864984, 10925.890741092488, 15103.4713785017, 15203.0, 15206.0, 15217.163056032025, 15228.314725837365, 7961.601919903982, 8121.066077401057, 8136.1050284468665, 8231.09457959624, 8253.257206851413, 7766.844663106706, 7812.726554570563, 7854.725084622125, 7939.483933544301, 7954.960225198953, 5993.820185394445, 6257.186565746515, 6552.248055816569, 6556.639384833785, 6641.468682505388, 1942.2328180368675, 1950.4343740315433, 1960.3138901384402, 1994.2820584589535, 1999.640064788323, 938.6808485115093, 1085.0180586569168, 1086.7828032603534, 1094.8412480190327, 1108.7117349489029, 18970.62058758817, 19101.044947752558, 19994.90002549978, 20122.89938550327, 20213.393598192077, 1041.2971244409994, 1063.0379506546587, 1072.5066469424153, 1107.3854011023798, 1118.949647265875, 11049.060829829394, 11382.54469821198, 11484.598039068593, 11509.136814738928, 11515.424228788526, 453690.0, 457752.0, 460096.0, 461036.0, 462849.0, 52965.2055219172, 73155.0, 81213.59393202997, 83207.58396208101, 85868.0, 1038.5015192707542, 1064.084886997182, 1077.7467295185781, 1078.800421921947, 1080.713610893114, 17250.913745431193, 17288.13559322004, 17413.216405262046, 17621.647567048843, 17859.46421607354, 37580.436293456165, 38255.42616860694, 40264.79867600643, 42122.0, 42417.575824242595, 54746.726266368416, 56219.15671265016, 56665.716671416376, 57598.136027958775, 59791.10313345216, 12608.621741347773, 12704.0, 13007.089503734647, 13441.327933603476, 13535.59393218205, 14242.786358204843, 14254.928725356722, 14410.567682969528, 14696.11823290606, 14806.703865922405, 12376.876231237573, 12599.0, 12989.675258118245, 13022.544210952572, 13417.396217170055, 12311.384430778604, 12421.130520863815, 12478.625641230414, 12795.61613151607, 12979.545715899898, 12465.5013799447, 12601.18092323996, 12856.807147892601, 12941.611751647466, 13105.606831795061, 12468.251904885736, 12968.157069790434, 12971.09202355826, 13001.739965200832, 13008.609741707764, 12642.178258413174, 12750.61748147557, 12826.358682066046, 12901.612951611467, 12916.741665166832], "value": 9766.329673380966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.605672383371, 1509.2076659753632, 1557.050199378379, 1727.6717423689497, 1861.4415675297407, 8789.648414063438, 9170.724878253646, 9189.448633082011, 9415.105564971334, 9465.668701595445, 9113.726588202348, 9363.157315841572, 9375.296852736037, 9382.812343753121, 9392.765180870481, 1756.1219390304848, 2300.160441438871, 2400.543896659638, 2429.514097180562, 2457.103157347573, 2405.1461731085474, 2449.5590793657134, 2450.0812195426715, 2451.080844683244, 2454.1901172613084, 2406.5307265083316, 2466.1121996081397, 2469.09877894569, 2469.123461171276, 2470.5800013997664, 1916.2047750183658, 2327.9185228517003, 2386.5107652931106, 2391.5934291170543, 2408.6146216605257, 2336.7896889280046, 2359.3629719975684, 2368.135630494874, 2371.4664200554907, 2372.0, 9085.863712044325, 9186.770330741718, 9208.033156518535, 9210.769730756785, 9213.539323033889, 5330.147176451788, 5443.618946673734, 5449.5640348772, 5464.7540860660965, 5466.890662186734, 3618.6381361863864, 3629.564452265745, 3635.709143268559, 3649.8905032849057, 3692.280005398948, 1126.4142645824124, 1151.585429245471, 1159.6405114414474, 1159.9304041757437, 1174.0666170394557, 13098.607041788762, 13408.664783380493, 13410.26243556604, 13431.597052088453, 13471.393787279498, 4954.752262386866, 5028.572571331405, 5069.594432445396, 5080.466551012164, 5132.204508301219, 11187.944060279646, 11234.943825280821, 11239.0, 11243.943780281046, 11260.718482038015, 4734.786934587952, 5391.595630327741, 5504.174373843955, 5514.448555144534, 5521.972390138104, 4384.386185933972, 4461.152381047591, 4461.687681862303, 4925.187344088257, 5038.319826823332, 4253.914921701548, 4266.530681625019, 4319.546447623017, 4321.049369138785, 4367.344898265285, 1331.094855498251, 1363.4137320952086, 1364.2701154882288, 1367.7196174784344, 1367.8700523450257, 803.4897839871606, 906.9093090690878, 969.2924165359186, 973.6981535723949, 994.2791476179711, 5998.640081595118, 6154.292256390572, 6197.194364732646, 6217.9689101555105, 6222.0, 458.41552021172606, 465.17895913712323, 467.27105715084576, 471.79691785945704, 478.10355583281347, 4133.937990930139, 4230.64039556635, 4237.724547904377, 4245.830166793356, 4309.439772829513, 10983.505742241618, 11716.297022178696, 11737.178397512092, 11761.941190293994, 11769.411529423494, 11155.776884462428, 11562.94218528902, 11630.6510804676, 11662.416879156008, 11794.941025294991, 8333.458325208841, 8366.832663346699, 8368.3305335573, 8395.370347223983, 8398.0, 5885.529157667291, 5920.467157955804, 5962.25471816023, 5963.761449541969, 6196.566240363131, 9846.803063938825, 10235.283530152818, 10451.68644940653, 10458.68623941283, 10536.209784266057, 10536.315139515908, 10674.412907290174, 10717.464126793473, 10730.785384292114, 10837.187210959051, 7313.232110628307, 7478.887816682863, 7654.578998155155, 8083.151269116658, 8273.627686754231, 8694.0, 8705.91294087051, 8742.213200811957, 8780.209781119729, 8786.341024423322, 7810.179931107379, 7895.526268423913, 8131.7560473185895, 8152.307053900247, 8223.21879421454, 7824.334931530883, 7958.442908996315, 8098.109207986999, 8116.066652335057, 8149.674013039412, 7113.0753002109395, 7114.750983715545, 7214.603196824225, 7282.344588987016, 7285.453590980804, 5072.721000344869, 5085.059264036166, 5092.618053646065, 5108.361454818148, 5199.66202196856, 5147.768350424165, 5200.167973124282, 5206.297149884717, 5315.880860157631, 5316.840494785162], "value": 4708.127711702802, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.3204047722409, 342.36149581031384, 344.07958710449543, 344.58133367957925, 351.49033900843773, 5272.710000949946, 5328.973355133228, 5331.520163185312, 5353.839384818452, 5416.783328666858, 5264.763085661145, 5290.841274761754, 5314.166612518685, 5325.2723093834375, 5364.704941228231, 3769.7738135711807, 3974.443577899089, 4061.1877624475073, 4122.361034039714, 4147.212029714345, 4144.8963775905695, 4150.377443383486, 4166.0, 4167.45823043004, 4190.805620398187, 4147.460830092084, 4169.4162817205615, 4186.0, 4187.790610469479, 4196.433481479991, 3938.6652134568594, 3955.5451123120633, 4025.7181997260204, 4060.309747342959, 4151.086760912594, 3683.594804571495, 3715.925681486382, 3719.6280371962857, 3733.533308336458, 3736.2999835074975, 5000.849974500771, 5001.424836143818, 5010.599152067826, 5016.8176843073015, 5114.616403769732, 4518.164139634178, 4731.243001119804, 4746.715197088186, 4776.546228108324, 4811.831585894477, 5465.9180112298345, 5472.151816468454, 5484.681767530667, 5505.944940550623, 5515.338159420855, 3980.5223373195113, 4025.8590949316927, 4027.7583344999393, 4029.073313137995, 4037.0, 5452.890942181134, 5717.742701578439, 5726.4273572642405, 5800.53595712342, 5808.2449281593545, 4112.979435102805, 4126.596957034622, 4141.233871733739, 4146.896327591774, 4158.9376159357635, 4138.089620283533, 4143.37849322598, 4149.647279981175, 4160.375943608423, 4203.054312779661, 4514.887127821765, 4699.6240300776535, 4707.270373092176, 4735.621150307967, 4749.857504274808, 5460.208269800856, 5508.0, 5542.0928245586765, 5569.582281328917, 5584.190292407578, 1391.4573316406406, 1396.7206558688304, 1399.5661344983089, 1406.9648258793611, 1417.4967886400386, 894.7339514586787, 902.0573500691793, 903.0, 931.7111695374456, 953.2374100719535, 4666.533346665374, 4766.594839438617, 4772.785224664898, 4789.185838407479, 4801.831935882227, 5030.622703297267, 5054.2671312660195, 5059.0, 5071.873203169876, 5084.8220312288895, 4530.343100250511, 4726.665075196942, 4741.786619602126, 4780.665353425296, 4807.879803004953, 2716.511028014976, 2720.836749794979, 2724.501524161703, 2735.5623100304256, 2787.6097346371525, 5232.136697444879, 5233.267342572043, 5249.317588713519, 5249.873801110556, 5255.159174532133, 4938.728369939616, 5127.461616530285, 5128.410232823273, 5173.793048278027, 5178.741062946838, 5121.769520371592, 5172.844814655567, 5201.375834899836, 5217.243499692523, 5240.069947539346, 5019.974900125476, 5032.986805277918, 5058.964621227381, 5088.771005304844, 5102.4642412546145, 4947.950520494749, 5022.397312322545, 5229.843104706712, 5711.0, 5714.285714285715, 5873.9412605873395, 5931.635723783467, 5959.940400596112, 5972.193753843176, 5978.611390259619, 4018.1762738639095, 4025.3835007245525, 4034.9193016138925, 4041.85853495138, 4049.1901619675596, 5467.289252397163, 5667.829965101054, 5671.262735844314, 5730.971345143247, 5737.397573254748, 5526.47498487643, 5531.2532808072, 5591.524720398812, 5594.636348637326, 5605.730613223557, 5299.894002120013, 5512.924979628934, 5533.806316778893, 5582.944170558405, 5660.320761508646, 5461.1262198048125, 5464.098423760035, 5476.64606637732, 5476.726163691879, 5499.697516636464, 5566.777328906798, 5599.412061733459, 5605.971970140124, 5615.803446879339, 5644.85887852807, 5210.53105220532, 5426.647267927572, 5442.156465747816, 5518.862028449321, 5523.502884740393], "value": 4123.479087995419, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.8152406470576, 856.5374697663262, 859.7592674051268, 871.6121326009924, 883.1389395339545, 13057.869421305795, 14116.294185290746, 14150.50473233437, 14202.07686500378, 14276.785848212272, 14222.71554568908, 14257.215853128073, 14293.78559321611, 14319.0, 14342.06776559523, 687.1753895325604, 706.2125729811249, 706.4913262451028, 832.592029905345, 844.1389782421926, 704.1128178495081, 813.8616435206029, 845.0577605969331, 846.0524212881581, 846.1876598465481, 889.2752406788479, 893.3880292000001, 894.9910500895005, 895.4492986813128, 895.5880295064246, 736.6648175080326, 891.9108089191094, 893.196123488862, 893.2005854759985, 893.6068130022802, 631.9178506794133, 640.478010421505, 643.3598569423453, 645.6416688737748, 647.3882181338637, 13228.074034817566, 13256.933715331457, 13288.601341959757, 13335.73328533424, 13428.664283392896, 12923.87076129236, 13506.86493135066, 13542.661433464144, 13557.728845423135, 13758.65603359914, 11827.34949577773, 12101.273923564615, 12111.273323600612, 12152.0, 12316.322602256872, 4444.0, 4532.628478197252, 4537.591616754475, 4545.863624091283, 4551.463925489106, 53513.73243133799, 54249.45750542523, 56280.71859640717, 56537.15194272089, 56768.14847777328, 11251.268667536584, 11301.830472542919, 11356.48895799691, 11382.373969431595, 11389.829152562717, 19943.301984430476, 19963.700544491843, 19972.90013549923, 19988.300409485597, 20001.499962501053, 8176.959115204505, 8293.170682931779, 8366.37252206087, 8373.665053397795, 8617.655293788304, 4709.858704238878, 4791.808327666924, 4902.8774280643265, 4921.557059864629, 4996.650234483552, 3324.7173990210617, 3399.7790143640586, 3409.1136304560496, 3413.317336532654, 3414.8804791832167, 617.2315467243311, 624.7719582352499, 631.3024108360196, 636.226984214182, 648.1412128929188, 555.8193587084133, 609.0926705186181, 614.7888659341091, 637.171676820132, 659.3472462262325, 9655.468949207721, 9789.21686265097, 9803.411795292306, 9846.704598862045, 9883.11052005323, 644.7002144003061, 677.522346745553, 714.5319815520842, 719.4747834081151, 748.1060133140844, 4514.774261286922, 4516.593506584423, 4674.345591617176, 4730.95269047312, 4806.375171227718, 60501.69749151226, 61613.0, 61835.690821545606, 69294.65352673204, 71903.64048179725, 59655.70172149198, 59798.402015979285, 59933.70033149806, 63568.0, 63759.0, 57038.714806426535, 57437.42562574404, 57600.42399576034, 57625.42374576285, 58470.99999999915, 9750.756231093996, 9815.214782817215, 9890.307678462439, 9913.752156196153, 9992.150667193078, 37508.43737343887, 37747.43378849374, 37876.81061594674, 37930.241395172496, 38210.235795283385, 43638.0, 46255.76872115618, 48822.755886220344, 49648.751756240985, 50040.0, 12470.56353027676, 12507.687307817014, 12706.428210730724, 12721.745297288631, 12861.164024338388, 13641.727165456437, 13880.51418200358, 13936.721265574835, 14840.0, 14846.77729834075, 12867.292298923649, 12946.741065178832, 13311.733765324445, 13653.658658533615, 13717.45130194781, 12965.546205882749, 12973.286469243905, 13568.1859088455, 13621.922750950342, 14124.364403601658, 12508.562200322946, 13269.933650331686, 13333.933330333286, 13519.459221631025, 13713.314334283046, 11212.27120237182, 11256.943715281372, 11261.793334429847, 11273.267237629529, 11549.94225028903, 10562.577496900038, 11250.156238281998, 11313.434328283718, 11315.603953861575, 11424.257423267461], "value": 6984.717123359833, "unit": "score"}], "name": "dromaeo_css", "value": 7248.297984505767, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 108.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 157.0, 221.0, 130.0, 156.0, 149.0, 126.0, 189.0, 123.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 156.0, 76.0, 75.0, 75.0, 74.0, 126.0, 74.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 148.0, 93.0, 91.0, 91.0, 123.0, 92.0, 93.0, 121.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 55.0, 54.0, 53.0, 106.0, 52.0, 52.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 78.0, 84.0, 79.0, 79.0, 80.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 128.0, 126.0, 118.0, 128.0, 127.0, 118.0, 191.0, 124.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 171.0, 160.0, 165.0, 161.0, 157.0, 160.0, 158.0, 158.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 64.0, 62.0, 62.0, 62.0, 65.0, 69.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1524.0, "alertThreshold": 2.0}]} 10:26:08 INFO - Return code: 0 10:26:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:26:09 ERROR - # TBPL SUCCESS # 10:26:09 INFO - Running post-action listener: _resource_record_post_action 10:26:09 INFO - ##### 10:26:09 INFO - ##### Finished run-tests step (success) 10:26:09 INFO - ##### 10:26:09 INFO - Running post-run listener: _resource_record_post_run 10:26:10 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544280576; Read time: 20; Write time: 562056 10:26:10 INFO - TinderboxPrint: CPU usage
13.1% 10:26:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 10:26:10 INFO - TinderboxPrint: I/O write bytes / time
544,280,576 / 562,056 10:26:10 INFO - TinderboxPrint: CPU idle
8,261.4 (86.8%) 10:26:10 INFO - TinderboxPrint: CPU user
1,205.6 (12.7%) 10:26:10 INFO - TinderboxPrint: Swap in / out
0 / 0 10:26:10 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 254984192; Read time: 0; Write time: 294552 10:26:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289296384; Read time: 20; Write time: 267504 10:26:10 INFO - Running post-run listener: _upload_blobber_files 10:26:10 INFO - Blob upload gear active. 10:26:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:10 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 10:26:10 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'] 10:26:10 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 10:26:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:11 INFO - (blobuploader) - INFO - Done attempting. 10:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:11 INFO - (blobuploader) - INFO - Done attempting. 10:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:11 INFO - Return code: 0 10:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/faf5b64e2598b7f24c39f3fcf05e6c240c55b285cab1297b426a476233f7c8113ad00bd0ad28deb384c1116db6f232d19b2e5719bf814b9034ee9feef1b7ff49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbeef5478b9833011206ba92de015bbcf68104017d7b7a3dcbf3f82d6a20b79c68e406b9da20e14f192ea317f32778b9dfa8ecd781df47e6785bbd5de36f05cb"} 10:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:11 INFO - Contents: 10:26:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/faf5b64e2598b7f24c39f3fcf05e6c240c55b285cab1297b426a476233f7c8113ad00bd0ad28deb384c1116db6f232d19b2e5719bf814b9034ee9feef1b7ff49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbeef5478b9833011206ba92de015bbcf68104017d7b7a3dcbf3f82d6a20b79c68e406b9da20e14f192ea317f32778b9dfa8ecd781df47e6785bbd5de36f05cb"} 10:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:11 INFO - Copying logs to upload dir... 10:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.114645 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-12 10:26:11.817410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 10:26:11.821070) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982 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/faf5b64e2598b7f24c39f3fcf05e6c240c55b285cab1297b426a476233f7c8113ad00bd0ad28deb384c1116db6f232d19b2e5719bf814b9034ee9feef1b7ff49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbeef5478b9833011206ba92de015bbcf68104017d7b7a3dcbf3f82d6a20b79c68e406b9da20e14f192ea317f32778b9dfa8ecd781df47e6785bbd5de36f05cb"} build_url:https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/BfYG2V16QFaaQ9tmX6zBbA/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/faf5b64e2598b7f24c39f3fcf05e6c240c55b285cab1297b426a476233f7c8113ad00bd0ad28deb384c1116db6f232d19b2e5719bf814b9034ee9feef1b7ff49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbeef5478b9833011206ba92de015bbcf68104017d7b7a3dcbf3f82d6a20b79c68e406b9da20e14f192ea317f32778b9dfa8ecd781df47e6785bbd5de36f05cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 10:26:11.845110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 10:26:11.845403) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463070204.461320-719876982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 10:26:11.930552) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 10:26:11.930888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 10:26:11.931180) ========= ========= Total master_lag: 0.19 =========