builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1464339453.89 results: success (0) buildid: 20160526233029 builduid: b7fcf669b36141df8d1d22af453ac8b2 revision: 4a7a28982402ba18d512b8d5cefa52b504d4ad9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:33.889793) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:33.890527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:33.890814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:33.935912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:33.936177) ========= 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=cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 01:57:34-- 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% 46.3M=0s 2016-05-27 01:57:34 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.068272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.068606) ========= 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=cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017836 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.121966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.122273) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4a7a28982402ba18d512b8d5cefa52b504d4ad9c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4a7a28982402ba18d512b8d5cefa52b504d4ad9c --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=cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 01:57:34,374 truncating revision to first 12 chars 2016-05-27 01:57:34,374 Setting DEBUG logging. 2016-05-27 01:57:34,375 attempt 1/10 2016-05-27 01:57:34,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4a7a28982402?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 01:57:34,741 unpacking tar archive at: fx-team-4a7a28982402/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706536 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.853356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.853655) ========= script_repo_revision: 4a7a28982402ba18d512b8d5cefa52b504d4ad9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.854037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.854301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:34.868094) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-27 01:57:34.868491) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:57:35 INFO - MultiFileLogger online at 20160527 01:57:35 in /builds/slave/test 01:57:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:57:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:57:35 INFO - {'append_to_log': False, 01:57:35 INFO - 'base_work_dir': '/builds/slave/test', 01:57:35 INFO - 'blob_upload_branch': 'Fx-Team', 01:57:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:57:35 INFO - 'branch': 'Fx-Team', 01:57:35 INFO - 'buildbot_json_path': 'buildprops.json', 01:57:35 INFO - 'config_files': ('talos/linux_config.py',), 01:57:35 INFO - 'default_actions': ('clobber', 01:57:35 INFO - 'read-buildbot-config', 01:57:35 INFO - 'download-and-extract', 01:57:35 INFO - 'populate-webroot', 01:57:35 INFO - 'create-virtualenv', 01:57:35 INFO - 'install', 01:57:35 INFO - 'run-tests'), 01:57:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:57:35 INFO - 'download_minidump_stackwalk': True, 01:57:35 INFO - 'download_symbols': 'ondemand', 01:57:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:57:35 INFO - 'tooltool.py': '/tools/tooltool.py', 01:57:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:57:35 INFO - '/tools/misc-python/virtualenv.py')}, 01:57:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:57:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:57:35 INFO - 'installer_path': 'installer.exe', 01:57:35 INFO - 'log_level': 'info', 01:57:35 INFO - 'log_name': 'talos', 01:57:35 INFO - 'log_to_console': True, 01:57:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:57:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:57:35 INFO - 'opt_config_files': (), 01:57:35 INFO - 'pip_index': False, 01:57:35 INFO - 'sps_profile': False, 01:57:35 INFO - 'sps_profile_interval': 0, 01:57:35 INFO - 'suite': 'dromaeojs-e10s', 01:57:35 INFO - 'system_bits': '32', 01:57:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:57:35 INFO - 'title': 'talos-linux64-ix-054', 01:57:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:57:35 INFO - 'use_talos_json': True, 01:57:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:57:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:57:35 INFO - 'work_dir': 'build'} 01:57:35 INFO - ##### 01:57:35 INFO - ##### Running clobber step. 01:57:35 INFO - ##### 01:57:35 INFO - Running pre-action listener: _resource_record_pre_action 01:57:35 INFO - Running main action method: clobber 01:57:35 INFO - rmtree: /builds/slave/test/build 01:57:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:57:35 INFO - Running post-action listener: _resource_record_post_action 01:57:35 INFO - ##### 01:57:35 INFO - ##### Finished clobber step (success) 01:57:35 INFO - ##### 01:57:35 INFO - ##### 01:57:35 INFO - ##### Running read-buildbot-config step. 01:57:35 INFO - ##### 01:57:35 INFO - Running pre-action listener: _resource_record_pre_action 01:57:35 INFO - Running main action method: read_buildbot_config 01:57:35 INFO - Using buildbot properties: 01:57:35 INFO - { 01:57:35 INFO - "project": "", 01:57:35 INFO - "product": "firefox", 01:57:35 INFO - "script_repo_revision": "production", 01:57:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:57:35 INFO - "repository": "", 01:57:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:57:35 INFO - "buildid": "20160526233029", 01:57:35 INFO - "pgo_build": "True", 01:57:35 INFO - "basedir": "/builds/slave/test", 01:57:35 INFO - "buildnumber": 504, 01:57:35 INFO - "slavename": "talos-linux64-ix-054", 01:57:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:57:35 INFO - "platform": "ubuntu64_hw", 01:57:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:57:35 INFO - "branch": "fx-team", 01:57:35 INFO - "repo_path": "integration/fx-team", 01:57:35 INFO - "revision": "4a7a28982402ba18d512b8d5cefa52b504d4ad9c", 01:57:35 INFO - "stage_platform": "linux64-pgo", 01:57:35 INFO - "builduid": "b7fcf669b36141df8d1d22af453ac8b2", 01:57:35 INFO - "slavebuilddir": "test" 01:57:35 INFO - } 01:57:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:57:35 INFO - Running post-action listener: _resource_record_post_action 01:57:35 INFO - ##### 01:57:35 INFO - ##### Finished read-buildbot-config step (success) 01:57:35 INFO - ##### 01:57:35 INFO - ##### 01:57:35 INFO - ##### Running download-and-extract step. 01:57:35 INFO - ##### 01:57:35 INFO - Running pre-action listener: _resource_record_pre_action 01:57:35 INFO - Running main action method: download_and_extract 01:57:35 INFO - mkdir: /builds/slave/test/build/tests 01:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:35 INFO - https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:37 INFO - Downloaded 1361 bytes. 01:57:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:57:37 INFO - Using the following test package requirements: 01:57:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:57:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:57:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:57:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:37 INFO - u'jsshell-linux-x86_64.zip'], 01:57:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:57:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:57:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:57:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:57:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:57:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:57:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:57:37 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')]} 01:57:37 INFO - https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:57:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:57:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:39 INFO - Downloaded 24410701 bytes. 01:57:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:57:40 INFO - Return code: 0 01:57:40 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 01:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:40 INFO - https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:50 INFO - Downloaded 24410701 bytes. 01:57:50 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'] 01:57:50 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 01:57:52 INFO - Return code: 0 01:57:52 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')]} 01:57:52 INFO - https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:53 INFO - Downloaded 10834034 bytes. 01:57:53 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'] 01:57:53 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 01:57:53 INFO - Return code: 0 01:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:53 INFO - https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cW_LBl-lSdKntAggwBDQvA/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 01:57:55 INFO - Downloaded 58718075 bytes. 01:57:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:57:55 INFO - mkdir: /builds/slave/test/properties 01:57:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:57:55 INFO - Writing to file /builds/slave/test/properties/build_url 01:57:55 INFO - Contents: 01:57:55 INFO - build_url:https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:57:55 INFO - Running post-action listener: _resource_record_post_action 01:57:55 INFO - Running post-action listener: set_extra_try_arguments 01:57:55 INFO - ##### 01:57:55 INFO - ##### Finished download-and-extract step (success) 01:57:55 INFO - ##### 01:57:55 INFO - ##### 01:57:55 INFO - ##### Running populate-webroot step. 01:57:55 INFO - ##### 01:57:55 INFO - Running pre-action listener: _resource_record_pre_action 01:57:55 INFO - Running main action method: populate_webroot 01:57:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:57:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:57:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:57:55 INFO - '--tppagecycles', 01:57:55 INFO - '7'], 01:57:55 INFO - 'tests': ['tsvgm']}}, 01:57:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:57:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:57:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:57:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:57:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:55 INFO - 'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:55 INFO - 'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['damp', 'tps']}, 01:57:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:55 INFO - 'tests': ['damp', 'tps']}, 01:57:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['dromaeo_dom']}, 01:57:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:57:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['a11yr', 01:57:55 INFO - 'ts_paint', 01:57:55 INFO - 'tpaint', 01:57:55 INFO - 'sessionrestore', 01:57:55 INFO - 'sessionrestore_no_auto_restore', 01:57:55 INFO - 'tabpaint']}, 01:57:55 INFO - 'other-e10s': {'tests': ['a11yr', 01:57:55 INFO - 'ts_paint', 01:57:55 INFO - 'tpaint', 01:57:55 INFO - 'sessionrestore', 01:57:55 INFO - 'sessionrestore_no_auto_restore', 01:57:55 INFO - 'tabpaint']}, 01:57:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:57:55 INFO - 'ts_paint', 01:57:55 INFO - 'tpaint', 01:57:55 INFO - 'sessionrestore', 01:57:55 INFO - 'sessionrestore_no_auto_restore', 01:57:55 INFO - 'tabpaint']}, 01:57:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:57:55 INFO - 'ts_paint', 01:57:55 INFO - 'tpaint', 01:57:55 INFO - 'sessionrestore', 01:57:55 INFO - 'sessionrestore_no_auto_restore', 01:57:55 INFO - 'tabpaint']}, 01:57:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['a11yr', 01:57:55 INFO - 'ts_paint', 01:57:55 INFO - 'tpaint', 01:57:55 INFO - 'sessionrestore', 01:57:55 INFO - 'sessionrestore_no_auto_restore', 01:57:55 INFO - 'tabpaint']}, 01:57:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['a11yr', 01:57:55 INFO - 'ts_paint', 01:57:55 INFO - 'tpaint', 01:57:55 INFO - 'sessionrestore', 01:57:55 INFO - 'sessionrestore_no_auto_restore', 01:57:55 INFO - 'tabpaint']}, 01:57:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['tsvgx', 01:57:55 INFO - 'tsvgr_opacity', 01:57:55 INFO - 'tart', 01:57:55 INFO - 'tscrollx', 01:57:55 INFO - 'cart']}, 01:57:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:57:55 INFO - 'tsvgr_opacity', 01:57:55 INFO - 'tart', 01:57:55 INFO - 'tscrollx', 01:57:55 INFO - 'cart']}, 01:57:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:55 INFO - 'talos_options': ['--disable-e10s'], 01:57:55 INFO - 'tests': ['tp5o']}, 01:57:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:55 INFO - 'tests': ['tp5o']}, 01:57:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:55 INFO - 'talos_options': ['--disable-e10s', 01:57:55 INFO - '--xperf_path', 01:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:55 INFO - 'tests': ['tp5n']}, 01:57:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:55 INFO - 'talos_options': ['--xperf_path', 01:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:55 INFO - 'tests': ['tp5n']}}, 01:57:55 INFO - 'talos.zip': {'path': '', 01:57:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:57:55 INFO - Running post-action listener: _resource_record_post_action 01:57:55 INFO - ##### 01:57:55 INFO - ##### Finished populate-webroot step (success) 01:57:55 INFO - ##### 01:57:55 INFO - ##### 01:57:55 INFO - ##### Running create-virtualenv step. 01:57:55 INFO - ##### 01:57:55 INFO - Running pre-action listener: _resource_record_pre_action 01:57:55 INFO - Running main action method: create_virtualenv 01:57:55 INFO - Creating virtualenv /builds/slave/test/build/venv 01:57:55 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 01:57:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:57:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:57:56 INFO - Using real prefix '/usr' 01:57:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:57:56 INFO - Installing distribute.............................................................................................................................................................................................done. 01:57:58 INFO - Installing pip.................done. 01:57:58 INFO - Return code: 0 01:57:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:57:58 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')]} 01:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:58 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')]} 01:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:58 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 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:57:58 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 01:57:58 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 01:57:58 INFO - Using env: {'DISPLAY': ':0', 01:57:58 INFO - 'HOME': '/home/cltbld', 01:57:58 INFO - 'LANG': 'en_US.UTF-8', 01:57:58 INFO - 'LANGUAGE': 'en_US:en', 01:57:58 INFO - 'LOGNAME': 'cltbld', 01:57:58 INFO - 'MAIL': '/var/mail/cltbld', 01:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:58 INFO - 'MOZ_NO_REMOTE': '1', 01:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:58 INFO - 'NO_EM_RESTART': '1', 01:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:58 INFO - 'PWD': '/builds/slave/test', 01:57:58 INFO - 'SHELL': '/bin/bash', 01:57:58 INFO - 'SHLVL': '1', 01:57:58 INFO - 'TERM': 'linux', 01:57:58 INFO - 'TMOUT': '86400', 01:57:58 INFO - 'USER': 'cltbld', 01:57:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:58 INFO - '_': '/tools/buildbot/bin/python'} 01:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:58 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 01:57:58 INFO - Cleaning up... 01:57:58 INFO - Return code: 0 01:57:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:57:58 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')]} 01:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:58 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')]} 01:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:57:58 INFO - Using env: {'DISPLAY': ':0', 01:57:58 INFO - 'HOME': '/home/cltbld', 01:57:58 INFO - 'LANG': 'en_US.UTF-8', 01:57:58 INFO - 'LANGUAGE': 'en_US:en', 01:57:58 INFO - 'LOGNAME': 'cltbld', 01:57:58 INFO - 'MAIL': '/var/mail/cltbld', 01:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:58 INFO - 'MOZ_NO_REMOTE': '1', 01:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:58 INFO - 'NO_EM_RESTART': '1', 01:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:58 INFO - 'PWD': '/builds/slave/test', 01:57:58 INFO - 'SHELL': '/bin/bash', 01:57:58 INFO - 'SHLVL': '1', 01:57:58 INFO - 'TERM': 'linux', 01:57:58 INFO - 'TMOUT': '86400', 01:57:58 INFO - 'USER': 'cltbld', 01:57:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:58 INFO - '_': '/tools/buildbot/bin/python'} 01:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:58 INFO - Downloading/unpacking psutil>=3.1.1 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:58:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:00 INFO - Installing collected packages: psutil 01:58:00 INFO - Running setup.py install for psutil 01:58:01 INFO - building 'psutil._psutil_linux' extension 01:58:01 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 01:58:01 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 01:58:01 INFO - building 'psutil._psutil_posix' extension 01:58:01 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 01:58:01 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 01:58:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:01 INFO - Successfully installed psutil 01:58:01 INFO - Cleaning up... 01:58:01 INFO - Return code: 0 01:58:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:58:01 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')]} 01:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:01 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')]} 01:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:58:01 INFO - Using env: {'DISPLAY': ':0', 01:58:01 INFO - 'HOME': '/home/cltbld', 01:58:01 INFO - 'LANG': 'en_US.UTF-8', 01:58:01 INFO - 'LANGUAGE': 'en_US:en', 01:58:01 INFO - 'LOGNAME': 'cltbld', 01:58:01 INFO - 'MAIL': '/var/mail/cltbld', 01:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:01 INFO - 'MOZ_NO_REMOTE': '1', 01:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:01 INFO - 'NO_EM_RESTART': '1', 01:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:01 INFO - 'PWD': '/builds/slave/test', 01:58:01 INFO - 'SHELL': '/bin/bash', 01:58:01 INFO - 'SHLVL': '1', 01:58:01 INFO - 'TERM': 'linux', 01:58:01 INFO - 'TMOUT': '86400', 01:58:01 INFO - 'USER': 'cltbld', 01:58:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:01 INFO - '_': '/tools/buildbot/bin/python'} 01:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:58:01 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 01:58:01 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 01:58:01 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 01:58:01 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 01:58:01 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 01:58:01 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 01:58:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:58:03 INFO - Installing collected packages: mozsystemmonitor 01:58:03 INFO - Running setup.py install for mozsystemmonitor 01:58:03 INFO - Successfully installed mozsystemmonitor 01:58:03 INFO - Cleaning up... 01:58:03 INFO - Return code: 0 01:58:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:58:03 INFO - Using env: {'DISPLAY': ':0', 01:58:03 INFO - 'HOME': '/home/cltbld', 01:58:03 INFO - 'LANG': 'en_US.UTF-8', 01:58:03 INFO - 'LANGUAGE': 'en_US:en', 01:58:03 INFO - 'LOGNAME': 'cltbld', 01:58:03 INFO - 'MAIL': '/var/mail/cltbld', 01:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:03 INFO - 'MOZ_NO_REMOTE': '1', 01:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:03 INFO - 'NO_EM_RESTART': '1', 01:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:03 INFO - 'PWD': '/builds/slave/test', 01:58:03 INFO - 'SHELL': '/bin/bash', 01:58:03 INFO - 'SHLVL': '1', 01:58:03 INFO - 'TERM': 'linux', 01:58:03 INFO - 'TMOUT': '86400', 01:58:03 INFO - 'USER': 'cltbld', 01:58:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:03 INFO - '_': '/tools/buildbot/bin/python'} 01:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:04 INFO - Downloading/unpacking blobuploader==1.2.4 01:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:05 INFO - Downloading blobuploader-1.2.4.tar.gz 01:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:58:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:58:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:06 INFO - Downloading docopt-0.6.1.tar.gz 01:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:58:06 INFO - Installing collected packages: blobuploader, requests, docopt 01:58:06 INFO - Running setup.py install for blobuploader 01:58:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:58:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:58:07 INFO - Running setup.py install for requests 01:58:07 INFO - Running setup.py install for docopt 01:58:07 INFO - Successfully installed blobuploader requests docopt 01:58:07 INFO - Cleaning up... 01:58:07 INFO - Return code: 0 01:58:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:07 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 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:58:07 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 01:58:07 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 01:58:07 INFO - Using env: {'DISPLAY': ':0', 01:58:07 INFO - 'HOME': '/home/cltbld', 01:58:07 INFO - 'LANG': 'en_US.UTF-8', 01:58:07 INFO - 'LANGUAGE': 'en_US:en', 01:58:07 INFO - 'LOGNAME': 'cltbld', 01:58:07 INFO - 'MAIL': '/var/mail/cltbld', 01:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:07 INFO - 'MOZ_NO_REMOTE': '1', 01:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:07 INFO - 'NO_EM_RESTART': '1', 01:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:07 INFO - 'PWD': '/builds/slave/test', 01:58:07 INFO - 'SHELL': '/bin/bash', 01:58:07 INFO - 'SHLVL': '1', 01:58:07 INFO - 'TERM': 'linux', 01:58:07 INFO - 'TMOUT': '86400', 01:58:07 INFO - 'USER': 'cltbld', 01:58:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:07 INFO - '_': '/tools/buildbot/bin/python'} 01:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:07 INFO - Running setup.py (path:/tmp/pip-thivuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:07 INFO - Running setup.py (path:/tmp/pip-y0xPKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:07 INFO - Running setup.py (path:/tmp/pip-J39Zt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:07 INFO - Running setup.py (path:/tmp/pip-wGEn54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:08 INFO - Running setup.py (path:/tmp/pip-A06dw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:08 INFO - Running setup.py (path:/tmp/pip-CaTjkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:08 INFO - Running setup.py (path:/tmp/pip-8wxN2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:08 INFO - Running setup.py (path:/tmp/pip-UsBewo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:08 INFO - Running setup.py (path:/tmp/pip-Cs8Oeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:08 INFO - Running setup.py (path:/tmp/pip-xjRHL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:08 INFO - Running setup.py (path:/tmp/pip-2eN_0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:08 INFO - Running setup.py (path:/tmp/pip-Iv17f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:08 INFO - Running setup.py (path:/tmp/pip-xQ7mmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:08 INFO - Running setup.py (path:/tmp/pip-Igmp06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:08 INFO - Running setup.py (path:/tmp/pip-SOxGDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:08 INFO - Running setup.py (path:/tmp/pip-wg7Zeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:08 INFO - Running setup.py (path:/tmp/pip-jJBza9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:58:08 INFO - Running setup.py install for manifestparser 01:58:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Running setup.py install for mozcrash 01:58:09 INFO - Running setup.py install for mozdebug 01:58:09 INFO - Running setup.py install for mozdevice 01:58:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Running setup.py install for mozfile 01:58:09 INFO - Running setup.py install for mozhttpd 01:58:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Running setup.py install for mozinfo 01:58:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Running setup.py install for mozInstall 01:58:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Running setup.py install for mozleak 01:58:09 INFO - Running setup.py install for mozlog 01:58:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:58:09 INFO - Running setup.py install for moznetwork 01:58:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:58:10 INFO - Running setup.py install for mozprocess 01:58:10 INFO - Running setup.py install for mozprofile 01:58:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:58:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:58:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:58:10 INFO - Running setup.py install for mozrunner 01:58:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:58:10 INFO - Running setup.py install for mozscreenshot 01:58:10 INFO - Running setup.py install for moztest 01:58:10 INFO - Running setup.py install for mozversion 01:58:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:58:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:58:10 INFO - Cleaning up... 01:58:10 INFO - Return code: 0 01:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:10 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 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:58:10 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 01:58:10 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 01:58:10 INFO - Using env: {'DISPLAY': ':0', 01:58:10 INFO - 'HOME': '/home/cltbld', 01:58:10 INFO - 'LANG': 'en_US.UTF-8', 01:58:10 INFO - 'LANGUAGE': 'en_US:en', 01:58:10 INFO - 'LOGNAME': 'cltbld', 01:58:10 INFO - 'MAIL': '/var/mail/cltbld', 01:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:10 INFO - 'MOZ_NO_REMOTE': '1', 01:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:10 INFO - 'NO_EM_RESTART': '1', 01:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:10 INFO - 'PWD': '/builds/slave/test', 01:58:10 INFO - 'SHELL': '/bin/bash', 01:58:10 INFO - 'SHLVL': '1', 01:58:10 INFO - 'TERM': 'linux', 01:58:10 INFO - 'TMOUT': '86400', 01:58:10 INFO - 'USER': 'cltbld', 01:58:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:10 INFO - '_': '/tools/buildbot/bin/python'} 01:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:10 INFO - Running setup.py (path:/tmp/pip-YBrHe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:11 INFO - Running setup.py (path:/tmp/pip-2ONvHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:11 INFO - Running setup.py (path:/tmp/pip-koZAAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:11 INFO - Running setup.py (path:/tmp/pip-s_0W9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:11 INFO - Running setup.py (path:/tmp/pip-1nJBOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:11 INFO - Running setup.py (path:/tmp/pip-xOn2Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:11 INFO - Running setup.py (path:/tmp/pip-4v73ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:11 INFO - Running setup.py (path:/tmp/pip-6PAKfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:11 INFO - Running setup.py (path:/tmp/pip-gogRFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:11 INFO - Running setup.py (path:/tmp/pip-hsAL8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:11 INFO - Running setup.py (path:/tmp/pip-FBMfRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:11 INFO - Running setup.py (path:/tmp/pip-ctrnKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:11 INFO - Running setup.py (path:/tmp/pip-cHEt8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:11 INFO - Running setup.py (path:/tmp/pip-Ry2wZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:11 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)) 01:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:11 INFO - Running setup.py (path:/tmp/pip-E9eT7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:12 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)) 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:12 INFO - Running setup.py (path:/tmp/pip-QrZrqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:12 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)) 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:12 INFO - Running setup.py (path:/tmp/pip-4M7o5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:12 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)) 01:58:12 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)) 01:58:12 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)) 01:58:12 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)) 01:58:12 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)) 01:58:12 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)) 01:58:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:14 INFO - Downloading blessings-1.6.tar.gz 01:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:58:14 INFO - Installing collected packages: blessings 01:58:14 INFO - Running setup.py install for blessings 01:58:14 INFO - Successfully installed blessings 01:58:14 INFO - Cleaning up... 01:58:14 INFO - Return code: 0 01:58:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:14 INFO - Reading from file tmpfile_stdout 01:58:14 INFO - Current package versions: 01:58:14 INFO - argparse == 1.2.1 01:58:14 INFO - blessings == 1.6 01:58:14 INFO - blobuploader == 1.2.4 01:58:14 INFO - docopt == 0.6.1 01:58:14 INFO - manifestparser == 1.1 01:58:14 INFO - mozInstall == 1.12 01:58:14 INFO - mozcrash == 0.17 01:58:14 INFO - mozdebug == 0.1 01:58:14 INFO - mozdevice == 0.48 01:58:14 INFO - mozfile == 1.2 01:58:14 INFO - mozhttpd == 0.7 01:58:14 INFO - mozinfo == 0.9 01:58:14 INFO - mozleak == 0.1 01:58:14 INFO - mozlog == 3.2 01:58:14 INFO - moznetwork == 0.27 01:58:14 INFO - mozprocess == 0.22 01:58:14 INFO - mozprofile == 0.28 01:58:14 INFO - mozrunner == 6.11 01:58:14 INFO - mozscreenshot == 0.1 01:58:14 INFO - mozsystemmonitor == 0.3 01:58:14 INFO - moztest == 0.7 01:58:14 INFO - mozversion == 1.4 01:58:14 INFO - psutil == 3.1.1 01:58:14 INFO - requests == 1.2.3 01:58:14 INFO - wsgiref == 0.1.2 01:58:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:14 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')]} 01:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:14 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')]} 01:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:14 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 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:58:14 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 01:58:14 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 01:58:14 INFO - Using env: {'DISPLAY': ':0', 01:58:14 INFO - 'HOME': '/home/cltbld', 01:58:14 INFO - 'LANG': 'en_US.UTF-8', 01:58:14 INFO - 'LANGUAGE': 'en_US:en', 01:58:14 INFO - 'LOGNAME': 'cltbld', 01:58:14 INFO - 'MAIL': '/var/mail/cltbld', 01:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:14 INFO - 'MOZ_NO_REMOTE': '1', 01:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:14 INFO - 'NO_EM_RESTART': '1', 01:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:14 INFO - 'PWD': '/builds/slave/test', 01:58:14 INFO - 'SHELL': '/bin/bash', 01:58:14 INFO - 'SHLVL': '1', 01:58:14 INFO - 'TERM': 'linux', 01:58:14 INFO - 'TMOUT': '86400', 01:58:14 INFO - 'USER': 'cltbld', 01:58:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:14 INFO - '_': '/tools/buildbot/bin/python'} 01:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 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)) 01:58:14 INFO - Cleaning up... 01:58:14 INFO - Return code: 0 01:58:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:58:14 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')]} 01:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:14 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')]} 01:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:14 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 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:58:14 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 01:58:14 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 01:58:14 INFO - Using env: {'DISPLAY': ':0', 01:58:14 INFO - 'HOME': '/home/cltbld', 01:58:14 INFO - 'LANG': 'en_US.UTF-8', 01:58:14 INFO - 'LANGUAGE': 'en_US:en', 01:58:14 INFO - 'LOGNAME': 'cltbld', 01:58:14 INFO - 'MAIL': '/var/mail/cltbld', 01:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:14 INFO - 'MOZ_NO_REMOTE': '1', 01:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:14 INFO - 'NO_EM_RESTART': '1', 01:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:14 INFO - 'PWD': '/builds/slave/test', 01:58:14 INFO - 'SHELL': '/bin/bash', 01:58:14 INFO - 'SHLVL': '1', 01:58:14 INFO - 'TERM': 'linux', 01:58:14 INFO - 'TMOUT': '86400', 01:58:14 INFO - 'USER': 'cltbld', 01:58:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:14 INFO - '_': '/tools/buildbot/bin/python'} 01:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:14 INFO - Downloading/unpacking jsonschema 01:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:58:16 INFO - Downloading/unpacking functools32 (from jsonschema) 01:58:16 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 01:58:16 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 01:58:16 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 01:58:16 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 01:58:16 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 01:58:16 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 01:58:17 INFO - Downloading functools32-3.2.3-2.tar.gz 01:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:58:17 INFO - warning: no files found matching '*.txt' 01:58:17 INFO - no previously-included directories found matching 'build' 01:58:17 INFO - no previously-included directories found matching 'dist' 01:58:17 INFO - no previously-included directories found matching '.git*' 01:58:17 INFO - Installing collected packages: jsonschema, functools32 01:58:17 INFO - Running setup.py install for functools32 01:58:17 INFO - warning: no files found matching '*.txt' 01:58:17 INFO - no previously-included directories found matching 'build' 01:58:17 INFO - no previously-included directories found matching 'dist' 01:58:17 INFO - no previously-included directories found matching '.git*' 01:58:17 INFO - Successfully installed jsonschema functools32 01:58:17 INFO - Cleaning up... 01:58:17 INFO - Return code: 0 01:58:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:58:17 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')]} 01:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:17 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')]} 01:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:17 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 0x7f83962baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe78e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', '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 01:58:17 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 01:58:17 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 01:58:17 INFO - Using env: {'DISPLAY': ':0', 01:58:17 INFO - 'HOME': '/home/cltbld', 01:58:17 INFO - 'LANG': 'en_US.UTF-8', 01:58:17 INFO - 'LANGUAGE': 'en_US:en', 01:58:17 INFO - 'LOGNAME': 'cltbld', 01:58:17 INFO - 'MAIL': '/var/mail/cltbld', 01:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:17 INFO - 'MOZ_NO_REMOTE': '1', 01:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:17 INFO - 'NO_EM_RESTART': '1', 01:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:17 INFO - 'PWD': '/builds/slave/test', 01:58:17 INFO - 'SHELL': '/bin/bash', 01:58:17 INFO - 'SHLVL': '1', 01:58:17 INFO - 'TERM': 'linux', 01:58:17 INFO - 'TMOUT': '86400', 01:58:17 INFO - 'USER': 'cltbld', 01:58:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:17 INFO - '_': '/tools/buildbot/bin/python'} 01:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:17 INFO - Downloading/unpacking flake8 01:58:17 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 01:58:17 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 01:58:17 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 01:58:17 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 01:58:17 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 01:58:17 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 01:58:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:58:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:58:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:19 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 01:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:58:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:20 INFO - no previously-included directories found matching 'docs/_build' 01:58:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:58:20 INFO - Running setup.py install for pep8 01:58:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:20 INFO - no previously-included directories found matching 'docs/_build' 01:58:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:58:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:58:20 INFO - Cleaning up... 01:58:20 INFO - Return code: 0 01:58:20 INFO - Running post-action listener: _resource_record_post_action 01:58:20 INFO - Running post-action listener: _start_resource_monitoring 01:58:20 INFO - Starting resource monitoring. 01:58:20 INFO - ##### 01:58:20 INFO - ##### Finished create-virtualenv step (success) 01:58:20 INFO - ##### 01:58:20 INFO - ##### 01:58:20 INFO - ##### Running install step. 01:58:20 INFO - ##### 01:58:20 INFO - Running pre-action listener: _resource_record_pre_action 01:58:20 INFO - Running main action method: install 01:58:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:20 INFO - Reading from file tmpfile_stdout 01:58:20 INFO - Detecting whether we're running mozinstall >=1.0... 01:58:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:58:20 INFO - Reading from file tmpfile_stdout 01:58:20 INFO - Output received: 01:58:20 INFO - Usage: mozinstall [options] installer 01:58:20 INFO - Options: 01:58:20 INFO - -h, --help show this help message and exit 01:58:20 INFO - -d DEST, --destination=DEST 01:58:20 INFO - Directory to install application into. [default: 01:58:20 INFO - "/builds/slave/test"] 01:58:20 INFO - --app=APP Application being installed. [default: firefox] 01:58:20 INFO - mkdir: /builds/slave/test/build/application 01:58:20 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'] 01:58:20 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 01:58:37 INFO - Reading from file tmpfile_stdout 01:58:37 INFO - Output received: 01:58:37 INFO - /builds/slave/test/build/application/firefox/firefox 01:58:37 INFO - Running post-action listener: _resource_record_post_action 01:58:37 INFO - ##### 01:58:37 INFO - ##### Finished install step (success) 01:58:37 INFO - ##### 01:58:37 INFO - ##### 01:58:37 INFO - ##### Running run-tests step. 01:58:37 INFO - ##### 01:58:37 INFO - Running pre-action listener: _resource_record_pre_action 01:58:37 INFO - Running main action method: run_tests 01:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:58:37 INFO - Python 2.7.3 01:58:37 INFO - Return code: 0 01:58:37 INFO - grabbing minidump binary from tooltool 01:58:37 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')]} 01:58:37 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 0x1076b20>, '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 0x1077a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:58:37 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 01:58:37 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 01:58:37 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 01:58:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:58:37 INFO - Return code: 0 01:58:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:58:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:58:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:58:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:58:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:58:38 INFO - Return code: 0 01:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:58:38 INFO - Using env: {'DISPLAY': ':0', 01:58:38 INFO - 'HOME': '/home/cltbld', 01:58:38 INFO - 'LANG': 'en_US.UTF-8', 01:58:38 INFO - 'LANGUAGE': 'en_US:en', 01:58:38 INFO - 'LOGNAME': 'cltbld', 01:58:38 INFO - 'MAIL': '/var/mail/cltbld', 01:58:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:58:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:38 INFO - 'MOZ_NO_REMOTE': '1', 01:58:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:38 INFO - 'NO_EM_RESTART': '1', 01:58:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:38 INFO - 'PWD': '/builds/slave/test', 01:58:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:58:38 INFO - 'SHELL': '/bin/bash', 01:58:38 INFO - 'SHLVL': '1', 01:58:38 INFO - 'TERM': 'linux', 01:58:38 INFO - 'TMOUT': '86400', 01:58:38 INFO - 'USER': 'cltbld', 01:58:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956', 01:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:38 INFO - '_': '/tools/buildbot/bin/python'} 01:58:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:58:38 INFO - mozversion application_buildid: 20160526233029 01:58:38 INFO - mozversion application_changeset: 4a7a28982402ba18d512b8d5cefa52b504d4ad9c 01:58:38 INFO - mozversion application_display_name: Nightly 01:58:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:58:38 INFO - mozversion application_name: Firefox 01:58:38 INFO - mozversion application_remotingname: firefox 01:58:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:58:38 INFO - mozversion application_vendor: Mozilla 01:58:38 INFO - mozversion application_version: 49.0a1 01:58:38 INFO - mozversion platform_buildid: 20160526233029 01:58:38 INFO - mozversion platform_changeset: 4a7a28982402ba18d512b8d5cefa52b504d4ad9c 01:58:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:58:38 INFO - mozversion platform_version: 49.0a1 01:58:38 INFO - using testdate: 1464339518 01:58:38 INFO - actual date: 1464339518 01:58:38 INFO - starting webserver on 'localhost:55045' 01:58:38 INFO - SUITE-START | Running 2 tests 01:58:38 INFO - TEST-START | dromaeo_css 01:58:38 INFO - operating with platform_type : linux_ 01:58:38 INFO - Initialising browser for dromaeo_css test... 01:58:38 INFO - TEST-INFO | started process 4564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOUQHRW/profile http://localhost:55045/getInfo.html) 01:58:43 INFO - PROCESS | 4564 | 01:58:43 INFO - PROCESS | 4564 | (process:4633): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:58:44 INFO - PROCESS | 4564 | __metrics Screen width/height:1600/1200 01:58:44 INFO - PROCESS | 4564 | colorDepth:24 01:58:44 INFO - PROCESS | 4564 | Browser inner width/height: 1024/697 01:58:44 INFO - PROCESS | 4564 | __metrics 01:58:44 ERROR - PROCESS | 4564 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 01:58:45 INFO - TEST-INFO | 4564: exit 0 01:58:45 INFO - Browser initialized. 01:58:45 INFO - Running cycle 1/1 for dromaeo_css test... 01:58:45 INFO - TEST-INFO | started process 4684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOUQHRW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:58:47 INFO - PROCESS | 4684 | 01:58:47 INFO - PROCESS | 4684 | (process:4746): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:58:57 INFO - PROCESS | 4684 | RSS: Main: 166019072 01:58:57 INFO - PROCESS | 4684 | 01:59:47 INFO - PROCESS | 4684 | 1464339587060 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] 02:01:55 INFO - PROCESS | 4684 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55045/tests/dromaeo/cssquery-ext.html) 02:01:56 INFO - PROCESS | 4684 | RSS: Main: 170020864 02:01:56 INFO - PROCESS | 4684 | 02:04:58 INFO - PROCESS | 4684 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-ext.html (next: http://localhost:55045/tests/dromaeo/cssquery-jquery.html) 02:04:58 INFO - PROCESS | 4684 | RSS: Main: 169283584 02:04:58 INFO - PROCESS | 4684 | 02:08:00 INFO - PROCESS | 4684 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55045/tests/dromaeo/cssquery-mootools.html) 02:08:01 INFO - PROCESS | 4684 | RSS: Main: 169537536 02:08:01 INFO - PROCESS | 4684 | 02:11:03 INFO - PROCESS | 4684 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55045/tests/dromaeo/cssquery-prototype.html) 02:11:03 INFO - PROCESS | 4684 | RSS: Main: 167497728 02:11:03 INFO - PROCESS | 4684 | 02:14:06 INFO - PROCESS | 4684 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55045/tests/dromaeo/cssquery-yui.html) 02:14:06 INFO - PROCESS | 4684 | RSS: Main: 169504768 02:14:06 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | Cycle 1(1): loaded http://localhost:55045/tests/dromaeo/cssquery-yui.html (next: http://localhost:55045/tests/dromaeo/cssquery-dojo.html) 02:17:09 INFO - PROCESS | 4684 | RSS: Main: 171081728 02:17:09 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | __start_tp_report 02:17:09 INFO - PROCESS | 4684 | _x_x_mozilla_page_load 02:17:09 INFO - PROCESS | 4684 | _x_x_mozilla_page_load_details 02:17:09 INFO - PROCESS | 4684 | |i|pagename|runs| 02:17:09 INFO - PROCESS | 4684 | |0;dojo.html;3072.646645635752;3097.98451007745;3158.3525377297656;3198.4882418812995;3206.134343727194;5493.560515158788;5505.174223866417;5512.972435137824;5574.358948720898;5583.246261754662;5378.623496355257;5444.891102177954;5516.724163791804;5521.365043020054;5523.447655234475;4958.652894297392;4990.975045124769;5007.899842003158;5086.821961231358;5156.742162891859;4982.103221420143;5161.225816127592;5179.663321884084;5182.740862956856;5190.351206099238;4880.6095512358925;4934.358533390672;4960.454350021495;5004.174311238641;5012.8496145115705;4963.354763880672;4965.875853103666;4968.478309777457;4981.825636102755;5023.974880125613;4936.90126197474;4942.382202224722;4951.678140920829;4953.306537084811;5007.974960125212;5268.972550352682;5341.412444631087;5398.217258497496;5403.5136837684795;5425.565954723613;5928.7332070056955;5929.644221346733;5939.643621382731;5947.464728174485;5956.076808094752;5871.089981052944;5997.640141591519;5998.550108741862;6004.669743164124;6007.7596896124105;5497.120460726304;5530.142827861688;5551.611387202897;5571;5576.888462230773;6070.332263451017;6108.541859360477;6109.75560977556;6111.35830737775;6127.601705889103;5724.742386592613;5783.537317014713;5820;5832.854178645568;5839.445252700986;5898.115282707542;5902.586818922634;5905;5918.141869428909;5967.37342579023;5767.192593036978;5796.101604251347;5812.070068789058;5863.736131874076;5869.941300586939;5855;5878.412158784087;5881.970590147107;5886.117082437669;5887.8233652990475;4375.759333236702;4383.1452866691325;4405.801738921757;4443.577860103285;4466.642668586505;3950.8419663213726;3962.5443074046275;3963.6829053675638;3999.5000624921886;4010.2380547695843;5463.535599474009;5624.156376543469;5633.549316054706;5642.322921249476;5668.149777533321;5880.176775251468;5914.935311643945;5930.762769489258;5974.61165024272;5988.9401105989255;5586.050371436865;5621.803236886771;5627.662340259598;5632.098864181793;5645.153227015899;4842.176829938919;4906.852794416173;4913.557779799835;4935.16102262609;4974.751262436864;6105.481034112061;6130.172426722335;6199.070139479114;6211.16149319836;6223.96888015557;5967.761289548543;5969.462748352669;5982.820515384633;5998.760049598141;6003.429674180946;5962.880742385215;5974.40255974399;5996.160537524663;6170.568060235741;6178.66017369031;5760.732638819453;5764.337101233412;5782.132680098019;5786.479216870502;5829.621074630136;5839.35767065614;5850.210221620197;5856.267966504187;5869.853253668522;5876.44173803488;5646.407127251744;5702.230198923258;5727.8568035799435;5766.567507437043;5807.157962095388;5597.832065038056;5702.258706368146;5719.170720245458;5719.771209151754;5756.165356023437;5696.088625819849;5722.427757224411;5725.2843394575675;5729;5748.913766293425;5622.8313150605545;5740.138979152994;5798.188253644409;5822.388649191774;5873.735681894411;5683.77264909399;5719.48524632785;5721.799737009184;5733.082706766897;5733.885322293448 02:17:09 INFO - PROCESS | 4684 | |1;ext.html;581.128307538692;612.5803824380298;637.3212528656977;638.9584976488323;659.6371995402527;38853.22293554131;42785.78607106964;42999.570004299945;43020.354694679605;43102.353464698055;43526.12947741051;43564.12871742571;44146.7792661037;44154;44261.557384426145;8493.532855692934;8568.485890846538;8651.48091114532;8669.21977022068;8684;8561.828763424728;8676.436031657953;8729.214370706635;8738.300935925143;8739.4756314621;8713.041565427799;8757.737267881974;8765.7808554786;8783.692570760024;8790.077041910603;8674.826503469958;8715.782105447382;8727.95636021819;8735.432196907244;8775.517346545937;8526.190011948855;8675.349348798802;8683.826323473495;8727.258183054448;8730.432521886121;40930.158142883345;41011;41065.79467102675;41192.58807411917;41316;3492.2142517933517;3517.067976986101;3609.386404311247;3633.8364773585254;4017.5178978522763;32002;32283.31538430844;32288.838555807306;32703.345933081204;33242.83378583092;4341.565843415665;4434.645228381722;4440.689151759379;4507.842225522124;4607.9308810367875;353027;353892.99999999744;355455;357115;357415;34305.48541771875;35316.64683353185;35389.292214155575;59017.40982590119;59367.70316148478;36862;36869.446958295644;37045.44431833525;37045.81477092597;37065.444018339746;14036.508722194674;14265.857341426452;14317.64205894861;14351.067180633225;14351.928240358731;11006.284591501688;11080.501377438035;11089.722756931142;11100.888991110147;11112.277701949348;8263.380246481538;8319.126491718403;8343.207395297559;8434.156584341517;8434.873476897852;3235.902922912316;3264.5756051713124;3288.194392373836;3296.258341873059;3319.6016478022307;1027.2347101409498;1065.8241390170535;1075.5912753153907;1141.57191053355;1223.149910811995;32449.675503244664;32705;32722.181945451077;33192.17019574482;33559.83220083884;1138.2658185470325;1139.6239241050598;1150.7871043856746;1232.1744431231098;1274.6558429224058;17184;17233.482995510156;17317.56706082358;17389.304427822746;17516.12419379026;533984;537273;537950;540059;540948;58709.70645146832;58930.70534647385;59166.70416647889;59474;59585;1327.3429652322163;1337.3914868734703;1385.6189547874415;1387.1538361599416;1392.7910813378073;31180.688193117778;31527;31632.367352652356;31732.20669483189;32471.350572987936;51689;51792.48207517876;52015.73992130015;52081.47918520766;52164.478355215964;317257;322600;325281;328221;328610;27566.448671026064;27864.86067569649;27906.16281511558;27953;28029.859850700617;47139.528604713516;48161;48569.271460927404;48572.2714159295;49543.50456495533;40783.38491546189;41274;41775.373369398876;41977;42570;40661.79669101635;41475;41768.95577610584;41977;41995.58004420039;41020.79489602533;42183;42592.5740742601;42664.78667606642;42712;35710.46434303436;36565.45151822671;36725.81637091797;37089.44365834461;37575.43636845395;28712;28819.27951801138;28839.7116028837;28914.566281505373;29229.561556576242 02:17:09 INFO - PROCESS | 4684 | |2;jquery.html;384.936485479896;390.05995550722747;395.0814356620857;395.78429755783094;405.37976895350107;18086.276548938025;19230.90384548079;19861.60276794465;19882.801171988274;20059.398218053444;18387.816121838776;18551.536211594717;19057.332993345237;19241;19327.806721932775;5401.972990135054;5446.2647542581835;5551.8889622207735;5860.794872179475;5869.647821130725;5656.208130861683;5780.884382312352;5799.304083509985;5800.419958004208;5814.24414826072;5553.222548843165;5697.173909783079;5713.942860571383;5765.596408251424;5772.971135144339;5728.140778883159;5729.541636669056;5746.396628354046;5753.309602847664;5754.338251101114;4961.131801934647;5234.319538459976;5267.9736601316745;5354.491323324278;5361.544268737162;13404.664883377896;13539.187648741106;13849;13860.306984650828;13884.23636699981;2285.108807565051;2295.4490922178725;2355.0344358812804;2396.424858034077;2516.245126462054;10255.589776408935;10495.527701253386;11722.94138529302;11827.526898924032;14990.250487475583;1936.8256856882808;2001.9199232030846;2018.5559176981042;2019.363900371393;2031.1976769176092;82045.17954820435;82486;82904.58547707283;82937.17062829355;83218.58390708007;10780.568777248822;10832.295900766425;11046.502907369188;11076.501557429934;11213.439328033566;15333.463328783662;15360.231988400536;15399.384024638888;15430;15448.922755386151;7540.208278130827;7698.730544430918;7794.649240784178;7823.295903368724;8042.396820238506;7084.716611335489;7138.179109402381;7187.748428804966;7215.927840721631;7321.158066822383;4674.158651442705;4688.320193571913;4698.694584851974;4732.645051621143;4872.4153101628035;1939.3406241877829;1968.8523360747715;1980.821726044663;1991.312997016027;2000.6998950157301;893.1738142218422;977.022977022977;994.194702291132;1029.953652085658;1030.6701855406197;17566;18370.540736481697;19464.902675486534;19525.121369538403;19562.413127606196;941.4727752458645;951.6193522591019;954.8997355277735;984.2863923655435;1032.5921261101823;10067.748306292402;10799;10829.512671929782;10858.2399232053;10891.400972946563;457457;469397;497828;499858;504660;53381.733091335074;70219.64890175516;94502;94928;97859.51070244603;958.9760255993656;961.8557216417454;985.5959056786826;996.0935548650693;1003.7641154328727;17621.383251586132;17932.28270869203;18001.54996125055;18051.909740451214;18323;40494.392584111854;40888.79555602322;41493.54772582945;42631;42684.359734603386;56061.43938560562;56467;57082;57674.4232557669;58095;6911.688973996082;7607.581583012766;8357.582120894052;8388.454750441202;8891.110888911056;12895.742085158432;12972.870271297166;13246.20522768637;13477.19136851792;13588.728225435238;11233.269837460539;11428.514303137623;11437.59968401102;11914.821277681016;11942.16404851652;9147.862782058408;11383.943080284545;11429.371384573597;11535.538578457103;11688.298702077902;11833.290002599872;11935;11965.222260553384;12022.63932082039;12216;8683.609237584198;8685.198799848917;8697.08680588529;8788.560571971504;8821.294296456397;11171.553137874394;12078.939605301917;12247.510099596273;12307.32309722938;12415.503379864704 02:17:09 INFO - PROCESS | 4684 | |3;mootools.html;1466.391447549267;1516.772484127381;1671.7492376143578;1794.0581194872698;1813.4287699374704;8135.7152499662525;8943.55282235888;9018.09819018098;9426.151646351835;9464;8648.69729559464;8889.066648001964;8941.776455588613;8942.239909607692;8993.865092023625;2332.1604222479937;2366.7278262999716;2368.751281115484;2375.4536456614987;2381.5832229359794;2322.6167682332393;2325.2559181062065;2364.6925899633025;2373.5134297468976;2379.7144342678816;2360.0913648245464;2361.515889242701;2378.167641325531;2380.92857214283;2382.845115067515;2274.0449011415244;2274.920377786778;2279.1225378229337;2280.5096904165603;2330.1727886600183;2256.029907139929;2266.5240299537118;2268.8184945204343;2282.897269622871;2284.3603790938396;9270.953645231799;9327.20718738908;9350.392224505453;9361.90638093624;9370.85943710845;5171;5294.576433885319;5297.364316282033;5298.231756395339;5310.92033619496;3110.7200351968204;3170.8097514149226;3265.7387409007224;3280.9835950820093;3287.4247006773717;956.9186619137382;962.1581116523042;977.5796407544752;1020.739711373595;1027.0140664961646;13094;13130.474781008748;13152.605421837361;13215;13238.735225295537;4425.845095421645;4585.426821647294;4636.327732478771;4651.348811166439;4654.743989080565;11136.554537818396;11198.776024479628;11203.271787333797;11204.047655949173;11265.774684506265;5339.652922560099;5352.170413585901;5379.35447746273;5398.64908780928;5407.324084489439;4267.615914567704;4693.882652933636;4847.200211965057;4850.805967761321;4981.153203955337;3877.554081280689;3908.120672848643;3997.420374045747;4005.839766409369;4007.6393124618926;1195.8937982366276;1197.1859135787574;1197.658667279821;1197.7544603356291;1199.9700007499707;820.5363969357294;913.5067063785482;932.077243528915;965.5124162298135;978.9559469823876;6093.238345206849;6206.193194884636;6231.22109736283;6341.746330146742;6382.904256436157;947.5735918836414;969.8739163908647;1020.403064207447;1020.4132623741378;1023.7594165371132;4087.2642924273914;4136.73111247774;4174.415581818548;4176.665866730715;4230.302000169999;11675.766484670428;11899.583514576949;11984.221025633306;12005.63983080509;12049.51801927913;11606.593769218205;11842.526298947945;11887.821682674767;11902.285862848257;11909.344986025679;8326.29226515753;8716.346274029473;8740.95629521861;8929.196372326522;8939.955300223457;6422.935770642233;6542.738290468328;6599.142111525471;6673.099131617169;6728.529002969745;10632.25574209798;10848.403337816495;11050.115990720884;11095.72260693489;11160.162987775788;10960.451977401257;11116.388598627153;11116.944415277872;11128.332300062022;11128.499217535069;7527.924720752722;8194.959025204837;8291.461055031645;8337.791555211168;8739.475631462132;8800;9002.369834111549;9056.954715226646;9108.043655416086;9136.63453461854;7765.689372425039;7895.64469598858;7919.683212671659;7959.920400795918;8137.715179968673;7960.681572737026;7971.282584567417;8040.557769322743;8171.7548473545885;8183.427160098736;7163.426925845815;7272.927270727437;7292.380147687506;7329.267073292628;7607.505512141693;5254.238135470259;5420.4850539198715;5428.83713488596;5534.52956498686;5664.971675141598;5059.797608095635;5455.8363249102595;5560.7219639018695;5718.256626638677;5787.826365209051 02:17:09 INFO - PROCESS | 4684 | |4;prototype.html;293.6578885598278;308.577249168639;309.8342386823049;328.14518180140726;330.1910319716694;5484.561235101192;5541.972290138554;5554.611177217596;5580.8280261145155;5668.433156684335;5559.527440167591;5577.44225577442;5581.972090139554;5606.046972014757;5615.466530679589;4277;4304.041661044217;4334.501532323776;4348.086901750628;4349.151915376503;4074.103697186614;4305.4715575970395;4325.913481730364;4347.347897815322;4379.4525684289465;4224.302990006645;4245.617894389505;4270.124624451995;4292.270314046619;4300.956990430087;4154.356074808409;4257.340112282601;4273.18809426208;4273.615374616299;4273.7008409411355;3732.346839303111;3732.608076151992;3735.62643735627;3738.12154143776;3754.643308885679;5345.3585569731495;5353;5372.247885296062;5388.407275199725;5389.622726409153;4763.737994410306;4881.535539338184;4944.87637809054;4967.4784147664695;4991.201407774775;5821.9811532981985;5866.882662346772;5897.970510147465;5898.254608323702;5910.615809972338;4060.167665628539;4109.178164367138;4120.979395103005;4121.5878412158845;4139.9793001035105;5888.499477544414;6080.391960803929;6081.726322315506;6123.601965872204;6125.356837532039;4097.282975479279;4136.958630413657;4141.4409054777825;4143.150654115899;4144.937825932613;4170.874873753793;4186.246475634415;4187.413762073312;4191.7484950903045;4199.601037901394;4791.257355109963;4849.951500485021;4855.271709243571;4875.34182885313;4885.5847252983895;5680.4319568042865;5858.209141765892;5882.382349853289;5909.8227053188475;5921.348651648315;1463.3488097796592;1467.8844078500417;1469.8608578351864;1478.9408423663149;1485.762278035509;876.8553188723916;895.1272509303377;896.9551522423852;902.7201567514091;914.3553794574809;5030.503799859136;5035.244713293036;5042.722650254198;5047.520485553867;5082.796688132434;5320.973395133077;5433.510984011458;5437.945620543744;5457.508824205841;5458.317710286215;5043.52086551777;5047.697138171721;5112.71880046601;5258.7370631468275;5689.203511508392;3206.8717251310154;3210.8234047127166;3223.6131664200448;3250.5449237106823;3251.1143536748627;6055.333913269536;6150.50795936324;6237.376262373727;6244.751889319841;6265.778173256172;6157.96921015392;6170.598911070766;6171.259448866075;6174.938250617526;6190.288116866528;6202.906956395657;6236.282827474898;6252.218472690914;6269.529785266123;6273.278572964167;5787.2187254720075;6018.578699490994;6037.366076561898;6044.879102418015;6047.909281360695;5932.525397968066;6027.246594175728;6049.153118563317;6110.358412366638;6122.265328160649;5997.250343707036;6207.782727604512;6270.968645156928;6285.842853928689;6318.778842740482;4193.664506839506;4216;4217.093324935154;4228.2600544905135;4231.894202644959;5863.941360586339;5872.618279811799;6055.212822333068;6080.391960803884;6137.539684523768;5825.679587622722;5848.2689663792025;5861.677607731615;5878.823635290948;5926.525877929669;5921.6743079131065;5935.792247271324;5937.228160339128;5943.940560594512;5954.910676339945;5556.666600004012;5716.228309178207;5764.913526297025;5810.767569297181;5828.825135245949;5884.58807883444;5921.822345329647;5944.375840536682;5950.375210602998;5955.583109182489;5659.320881494247;5695.914561281501;5750.9424905752085;5797.159411885337;5807.954568177768 02:17:09 INFO - PROCESS | 4684 | |5;yui.html;743.5390058163938;773.2885745114494;784;842.6797816829605;848.7665891879732;14806.851931480682;15723.528294151194;15799.368025279004;15819.367225310974;15843.920780396096;14376.49682261121;14442.205678687667;14458.710825783504;14481.493147739831;14543.054701444398;669.8057563306635;807.0920214758382;820.0774129104757;821.2977903892175;821.8602837517636;790.8734602463607;802.618756090858;806.5402720449317;807.5074204735107;808.0626473290984;852.5651917522077;858.6393714639867;859.4843094143527;860.3762272352526;863.0377129500624;847.7456762971084;850.3324889961351;851.6635928808117;853.4324674091722;857.0615176381914;624.356912380249;624.9125122482856;626.7054484392328;627.1345543150469;628.6322501336723;13158.407871645799;13224.801627975588;13276;13293.20240785556;13310.134841235289;13730.588082357544;13914.51299204523;14271.215083170422;14524.128552286897;14570.125792452487;11748.647540573797;11871.109666775026;11899.940500297529;11905.226160299639;12045.457954392074;3767.472553842464;3808.485854409647;3844.480995065658;3879.8836034919;3947.486826712509;58941;59027.704861475846;59110.40889591092;59126.40873591295;59155;10937.28907621018;11246.887531124748;11423.543058277575;11462.083033357312;11462.828057579143;20847.1661133556;21045.26341578068;21051.78948210498;21137;21141.89429052845;8364.53995030267;8374.143485502833;8534.103919088531;8572.957135214285;8586.356023298278;4589.5639914208095;4724.598409135193;4733.100710864925;4796.160671882476;4807.326974223612;3628.818559072036;3655.8720444784835;3718.1262403335195;3725.8509659613856;3748.2503499299705;612.6599737145838;629.0721186250336;648.2659879096439;663.3896814930275;665.9367360100782;627.3130921640796;687.4466054825913;746.7535713214626;754.1289810269147;755.4634420306027;9501.572429240563;9747.902520974842;9913.454759988126;10078.546465409074;10169.593216271267;692.6933312070893;735.9742409015658;739.548875186136;744.4836452789536;754.8603508350973;4673.789679464432;4862.246351815475;4864.294677271847;4867.829625963145;4877.902441951142;69727.65136174287;70730;71140.28859711337;71290;72813.27186728171;56067;57877.71061144752;64198.35801642017;64734.35265647378;65504.344956550776;56726.7163664179;57305;57451.13823292654;58668;59702.701486493155;9773.804523909339;9878.802423951336;10085.647002354883;10126;10134.746631334276;35357.292854143285;35949;36325.45511817272;38313;39478.2104357917;49085;49398.753006234736;49546.752266238436;49661.25508117453;50644.49355506545;12075.637730868088;12146.392680366123;12339.321337326533;12846.67883302925;12895.274768242449;14044.719105617625;14312.785308220176;14582.781258280922;14594.270286485846;14878.851211487747;13380.330983450984;13557.59327220185;13616.591502254949;13712.245826479639;14104.435822566982;12692.809607855705;12841.871581284067;13091.738165236451;13214.173628442812;14097.859021409655;12989;13022.348882556023;13037.15258508194;13265.137766045176;13826.170429774245;10848.728781780203;11083.334999900031;11302.943485282522;11537.480813363587;11541;10752.784944301227;11236.494357753758;11281.830772538255;11397.715057123638;11405.600803971822 02:17:09 INFO - PROCESS | 4684 | __end_tp_report 02:17:09 INFO - PROCESS | 4684 | __start_cc_report 02:17:09 INFO - PROCESS | 4684 | _x_x_mozilla_cycle_collect,340 02:17:09 INFO - PROCESS | 4684 | __end_cc_report 02:17:09 INFO - PROCESS | 4684 | __startTimestamp1464340629521__endTimestamp 02:17:09 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | ------- Summary: start ------- 02:17:09 INFO - PROCESS | 4684 | Number of tests: 6 02:17:09 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | [#0] dojo.html Cycles:165 Average:5471.59 Median:5719.17 stddev:644.61 (11.3%) stddev-sans-first:618.50 02:17:09 INFO - PROCESS | 4684 | Values: 3072.6 3098.0 3158.4 3198.5 3206.1 5493.6 5505.2 5513.0 5574.4 5583.2 5378.6 5444.9 5516.7 5521.4 5523.4 4958.7 4991.0 5007.9 5086.8 5156.7 4982.1 5161.2 5179.7 5182.7 5190.4 4880.6 4934.4 4960.5 5004.2 5012.8 4963.4 4965.9 4968.5 4981.8 5024.0 4936.9 4942.4 4951.7 4953.3 5008.0 5269.0 5341.4 5398.2 5403.5 5425.6 5928.7 5929.6 5939.6 5947.5 5956.1 5871.1 5997.6 5998.6 6004.7 6007.8 5497.1 5530.1 5551.6 5571.0 5576.9 6070.3 6108.5 6109.8 6111.4 6127.6 5724.7 5783.5 5820.0 5832.9 5839.4 5898.1 5902.6 5905.0 5918.1 5967.4 5767.2 5796.1 5812.1 5863.7 5869.9 5855.0 5878.4 5882.0 5886.1 5887.8 4375.8 4383.1 4405.8 4443.6 4466.6 3950.8 3962.5 3963.7 3999.5 4010.2 5463.5 5624.2 5633.5 5642.3 5668.1 5880.2 5914.9 5930.8 5974.6 5988.9 5586.1 5621.8 5627.7 5632.1 5645.2 4842.2 4906.9 4913.6 4935.2 4974.8 6105.5 6130.2 6199.1 6211.2 6224.0 5967.8 5969.5 5982.8 5998.8 6003.4 5962.9 5974.4 5996.2 6170.6 6178.7 5760.7 5764.3 5782.1 5786.5 5829.6 5839.4 5850.2 5856.3 5869.9 5876.4 5646.4 5702.2 5727.9 5766.6 5807.2 5597.8 5702.3 5719.2 5719.8 5756.2 5696.1 5722.4 5725.3 5729.0 5748.9 5622.8 5740.1 5798.2 5822.4 5873.7 5683.8 5719.5 5721.8 5733.1 5733.9 02:17:09 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | [#1] ext.html Cycles:180 Average:55902.23 Median:40856.77 stddev:110669.51 (270.9%) stddev-sans-first:110902.02 02:17:09 INFO - PROCESS | 4684 | Values: 581.1 612.6 637.3 639.0 659.6 38853.2 42785.8 42999.6 43020.4 43102.4 43526.1 43564.1 44146.8 44154.0 44261.6 8493.5 8568.5 8651.5 8669.2 8684.0 8561.8 8676.4 8729.2 8738.3 8739.5 8713.0 8757.7 8765.8 8783.7 8790.1 8674.8 8715.8 8728.0 8735.4 8775.5 8526.2 8675.3 8683.8 8727.3 8730.4 40930.2 41011.0 41065.8 41192.6 41316.0 3492.2 3517.1 3609.4 3633.8 4017.5 32002.0 32283.3 32288.8 32703.3 33242.8 4341.6 4434.6 4440.7 4507.8 4607.9 353027.0 353893.0 355455.0 357115.0 357415.0 34305.5 35316.6 35389.3 59017.4 59367.7 36862.0 36869.4 37045.4 37045.8 37065.4 14036.5 14265.9 14317.6 14351.1 14351.9 11006.3 11080.5 11089.7 11100.9 11112.3 8263.4 8319.1 8343.2 8434.2 8434.9 3235.9 3264.6 3288.2 3296.3 3319.6 1027.2 1065.8 1075.6 1141.6 1223.1 32449.7 32705.0 32722.2 33192.2 33559.8 1138.3 1139.6 1150.8 1232.2 1274.7 17184.0 17233.5 17317.6 17389.3 17516.1 533984.0 537273.0 537950.0 540059.0 540948.0 58709.7 58930.7 59166.7 59474.0 59585.0 1327.3 1337.4 1385.6 1387.2 1392.8 31180.7 31527.0 31632.4 31732.2 32471.4 51689.0 51792.5 52015.7 52081.5 52164.5 317257.0 322600.0 325281.0 328221.0 328610.0 27566.4 27864.9 27906.2 27953.0 28029.9 47139.5 48161.0 48569.3 48572.3 49543.5 40783.4 41274.0 41775.4 41977.0 42570.0 40661.8 41475.0 41769.0 41977.0 41995.6 41020.8 42183.0 42592.6 42664.8 42712.0 35710.5 36565.5 36725.8 37089.4 37575.4 28712.0 28819.3 28839.7 28914.6 29229.6 02:17:09 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | [#2] jquery.html Cycles:180 Average:28373.32 Median:395.43 stddev:80101.29 (20256.6%) stddev-sans-first:80298.42 02:17:09 INFO - PROCESS | 4684 | Values: 384.9 390.1 395.1 395.8 405.4 18086.3 19230.9 19861.6 19882.8 20059.4 18387.8 18551.5 19057.3 19241.0 19327.8 5402.0 5446.3 5551.9 5860.8 5869.6 5656.2 5780.9 5799.3 5800.4 5814.2 5553.2 5697.2 5713.9 5765.6 5773.0 5728.1 5729.5 5746.4 5753.3 5754.3 4961.1 5234.3 5268.0 5354.5 5361.5 13404.7 13539.2 13849.0 13860.3 13884.2 2285.1 2295.4 2355.0 2396.4 2516.2 10255.6 10495.5 11722.9 11827.5 14990.3 1936.8 2001.9 2018.6 2019.4 2031.2 82045.2 82486.0 82904.6 82937.2 83218.6 10780.6 10832.3 11046.5 11076.5 11213.4 15333.5 15360.2 15399.4 15430.0 15448.9 7540.2 7698.7 7794.6 7823.3 8042.4 7084.7 7138.2 7187.7 7215.9 7321.2 4674.2 4688.3 4698.7 4732.6 4872.4 1939.3 1968.9 1980.8 1991.3 2000.7 893.2 977.0 994.2 1030.0 1030.7 17566.0 18370.5 19464.9 19525.1 19562.4 941.5 951.6 954.9 984.3 1032.6 10067.7 10799.0 10829.5 10858.2 10891.4 457457.0 469397.0 497828.0 499858.0 504660.0 53381.7 70219.6 94502.0 94928.0 97859.5 959.0 961.9 985.6 996.1 1003.8 17621.4 17932.3 18001.5 18051.9 18323.0 40494.4 40888.8 41493.5 42631.0 42684.4 56061.4 56467.0 57082.0 57674.4 58095.0 6911.7 7607.6 8357.6 8388.5 8891.1 12895.7 12972.9 13246.2 13477.2 13588.7 11233.3 11428.5 11437.6 11914.8 11942.2 9147.9 11383.9 11429.4 11535.5 11688.3 11833.3 11935.0 11965.2 12022.6 12216.0 8683.6 8685.2 8697.1 8788.6 8821.3 11171.6 12078.9 12247.5 12307.3 12415.5 02:17:09 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | [#3] mootools.html Cycles:180 Average:6089.74 Median:4674.31 stddev:3600.73 (77.0%) stddev-sans-first:3594.07 02:17:09 INFO - PROCESS | 4684 | Values: 1466.4 1516.8 1671.7 1794.1 1813.4 8135.7 8943.6 9018.1 9426.2 9464.0 8648.7 8889.1 8941.8 8942.2 8993.9 2332.2 2366.7 2368.8 2375.5 2381.6 2322.6 2325.3 2364.7 2373.5 2379.7 2360.1 2361.5 2378.2 2380.9 2382.8 2274.0 2274.9 2279.1 2280.5 2330.2 2256.0 2266.5 2268.8 2282.9 2284.4 9271.0 9327.2 9350.4 9361.9 9370.9 5171.0 5294.6 5297.4 5298.2 5310.9 3110.7 3170.8 3265.7 3281.0 3287.4 956.9 962.2 977.6 1020.7 1027.0 13094.0 13130.5 13152.6 13215.0 13238.7 4425.8 4585.4 4636.3 4651.3 4654.7 11136.6 11198.8 11203.3 11204.0 11265.8 5339.7 5352.2 5379.4 5398.6 5407.3 4267.6 4693.9 4847.2 4850.8 4981.2 3877.6 3908.1 3997.4 4005.8 4007.6 1195.9 1197.2 1197.7 1197.8 1200.0 820.5 913.5 932.1 965.5 979.0 6093.2 6206.2 6231.2 6341.7 6382.9 947.6 969.9 1020.4 1020.4 1023.8 4087.3 4136.7 4174.4 4176.7 4230.3 11675.8 11899.6 11984.2 12005.6 12049.5 11606.6 11842.5 11887.8 11902.3 11909.3 8326.3 8716.3 8741.0 8929.2 8940.0 6422.9 6542.7 6599.1 6673.1 6728.5 10632.3 10848.4 11050.1 11095.7 11160.2 10960.5 11116.4 11116.9 11128.3 11128.5 7527.9 8195.0 8291.5 8337.8 8739.5 8800.0 9002.4 9057.0 9108.0 9136.6 7765.7 7895.6 7919.7 7959.9 8137.7 7960.7 7971.3 8040.6 8171.8 8183.4 7163.4 7272.9 7292.4 7329.3 7607.5 5254.2 5420.5 5428.8 5534.5 5665.0 5059.8 5455.8 5560.7 5718.3 5787.8 02:17:09 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | [#4] prototype.html Cycles:180 Average:4868.78 Median:5548.29 stddev:1462.61 (26.4%) stddev-sans-first:1425.83 02:17:09 INFO - PROCESS | 4684 | Values: 293.7 308.6 309.8 328.1 330.2 5484.6 5542.0 5554.6 5580.8 5668.4 5559.5 5577.4 5582.0 5606.0 5615.5 4277.0 4304.0 4334.5 4348.1 4349.2 4074.1 4305.5 4325.9 4347.3 4379.5 4224.3 4245.6 4270.1 4292.3 4301.0 4154.4 4257.3 4273.2 4273.6 4273.7 3732.3 3732.6 3735.6 3738.1 3754.6 5345.4 5353.0 5372.2 5388.4 5389.6 4763.7 4881.5 4944.9 4967.5 4991.2 5822.0 5866.9 5898.0 5898.3 5910.6 4060.2 4109.2 4121.0 4121.6 4140.0 5888.5 6080.4 6081.7 6123.6 6125.4 4097.3 4137.0 4141.4 4143.2 4144.9 4170.9 4186.2 4187.4 4191.7 4199.6 4791.3 4850.0 4855.3 4875.3 4885.6 5680.4 5858.2 5882.4 5909.8 5921.3 1463.3 1467.9 1469.9 1478.9 1485.8 876.9 895.1 897.0 902.7 914.4 5030.5 5035.2 5042.7 5047.5 5082.8 5321.0 5433.5 5437.9 5457.5 5458.3 5043.5 5047.7 5112.7 5258.7 5689.2 3206.9 3210.8 3223.6 3250.5 3251.1 6055.3 6150.5 6237.4 6244.8 6265.8 6158.0 6170.6 6171.3 6174.9 6190.3 6202.9 6236.3 6252.2 6269.5 6273.3 5787.2 6018.6 6037.4 6044.9 6047.9 5932.5 6027.2 6049.2 6110.4 6122.3 5997.3 6207.8 6271.0 6285.8 6318.8 4193.7 4216.0 4217.1 4228.3 4231.9 5863.9 5872.6 6055.2 6080.4 6137.5 5825.7 5848.3 5861.7 5878.8 5926.5 5921.7 5935.8 5937.2 5943.9 5954.9 5556.7 5716.2 5764.9 5810.8 5828.8 5884.6 5921.8 5944.4 5950.4 5955.6 5659.3 5695.9 5750.9 5797.2 5808.0 02:17:09 INFO - PROCESS | 4684 | 02:17:09 INFO - PROCESS | 4684 | [#5] yui.html Cycles:180 Average:16115.89 Median:4631.68 stddev:19254.92 (415.7%) stddev-sans-first:19274.33 02:17:09 INFO - PROCESS | 4684 | Values: 743.5 773.3 784.0 842.7 848.8 14806.9 15723.5 15799.4 15819.4 15843.9 14376.5 14442.2 14458.7 14481.5 14543.1 669.8 807.1 820.1 821.3 821.9 790.9 802.6 806.5 807.5 808.1 852.6 858.6 859.5 860.4 863.0 847.7 850.3 851.7 853.4 857.1 624.4 624.9 626.7 627.1 628.6 13158.4 13224.8 13276.0 13293.2 13310.1 13730.6 13914.5 14271.2 14524.1 14570.1 11748.6 11871.1 11899.9 11905.2 12045.5 3767.5 3808.5 3844.5 3879.9 3947.5 58941.0 59027.7 59110.4 59126.4 59155.0 10937.3 11246.9 11423.5 11462.1 11462.8 20847.2 21045.3 21051.8 21137.0 21141.9 8364.5 8374.1 8534.1 8573.0 8586.4 4589.6 4724.6 4733.1 4796.2 4807.3 3628.8 3655.9 3718.1 3725.9 3748.3 612.7 629.1 648.3 663.4 665.9 627.3 687.4 746.8 754.1 755.5 9501.6 9747.9 9913.5 10078.5 10169.6 692.7 736.0 739.5 744.5 754.9 4673.8 4862.2 4864.3 4867.8 4877.9 69727.7 70730.0 71140.3 71290.0 72813.3 56067.0 57877.7 64198.4 64734.4 65504.3 56726.7 57305.0 57451.1 58668.0 59702.7 9773.8 9878.8 10085.6 10126.0 10134.7 35357.3 35949.0 36325.5 38313.0 39478.2 49085.0 49398.8 49546.8 49661.3 50644.5 12075.6 12146.4 12339.3 12846.7 12895.3 14044.7 14312.8 14582.8 14594.3 14878.9 13380.3 13557.6 13616.6 13712.2 14104.4 12692.8 12841.9 13091.7 13214.2 14097.9 12989.0 13022.3 13037.2 13265.1 13826.2 10848.7 11083.3 11302.9 11537.5 11541.0 10752.8 11236.5 11281.8 11397.7 11405.6 02:17:09 INFO - PROCESS | 4684 | -------- Summary: end -------- 02:17:09 INFO - PROCESS | 4684 | 02:17:10 INFO - TEST-INFO | 4684: exit 0 02:17:10 INFO - TEST-OK | dromaeo_css | took 1111538ms 02:17:10 INFO - TEST-START | kraken 02:17:10 INFO - operating with platform_type : linux_ 02:17:10 INFO - Initialising browser for kraken test... 02:17:10 INFO - TEST-INFO | started process 4925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUl3GZV/profile http://localhost:55045/getInfo.html) 02:17:14 INFO - PROCESS | 4925 | 02:17:14 INFO - PROCESS | 4925 | (process:4991): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:17:14 INFO - PROCESS | 4925 | __metrics Screen width/height:1600/1200 02:17:14 INFO - PROCESS | 4925 | colorDepth:24 02:17:14 INFO - PROCESS | 4925 | Browser inner width/height: 1024/697 02:17:14 INFO - PROCESS | 4925 | __metrics 02:17:15 ERROR - PROCESS | 4925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 02:17:16 INFO - TEST-INFO | 4925: exit 0 02:17:16 INFO - Browser initialized. 02:17:16 INFO - Running cycle 1/1 for kraken test... 02:17:16 INFO - TEST-INFO | started process 5044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUl3GZV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:17:18 INFO - PROCESS | 5044 | 02:17:18 INFO - PROCESS | 5044 | (process:5104): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:17:28 INFO - PROCESS | 5044 | RSS: Main: 165916672 02:17:28 INFO - PROCESS | 5044 | 02:17:30 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55045/tests/kraken/driver.html?testName=audio-beat-detection) 02:17:31 INFO - PROCESS | 5044 | RSS: Main: 171470848 02:17:31 INFO - PROCESS | 5044 | 02:17:34 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55045/tests/kraken/driver.html?testName=audio-dft) 02:17:34 INFO - PROCESS | 5044 | RSS: Main: 170586112 02:17:34 INFO - PROCESS | 5044 | 02:17:37 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55045/tests/kraken/driver.html?testName=audio-fft) 02:17:38 INFO - PROCESS | 5044 | RSS: Main: 165482496 02:17:38 INFO - PROCESS | 5044 | 02:17:40 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55045/tests/kraken/driver.html?testName=audio-oscillator) 02:17:41 INFO - PROCESS | 5044 | RSS: Main: 166350848 02:17:41 INFO - PROCESS | 5044 | 02:17:43 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55045/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:17:43 INFO - PROCESS | 5044 | RSS: Main: 166264832 02:17:43 INFO - PROCESS | 5044 | 02:17:47 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55045/tests/kraken/driver.html?testName=imaging-darkroom) 02:17:47 INFO - PROCESS | 5044 | RSS: Main: 166383616 02:17:47 INFO - PROCESS | 5044 | 02:17:51 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55045/tests/kraken/driver.html?testName=imaging-desaturate) 02:17:51 INFO - PROCESS | 5044 | RSS: Main: 163971072 02:17:51 INFO - PROCESS | 5044 | 02:17:54 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55045/tests/kraken/driver.html?testName=json-parse-financial) 02:17:55 INFO - PROCESS | 5044 | RSS: Main: 166428672 02:17:55 INFO - PROCESS | 5044 | 02:17:56 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55045/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:17:57 INFO - PROCESS | 5044 | RSS: Main: 166690816 02:17:57 INFO - PROCESS | 5044 | 02:17:59 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:17:59 INFO - PROCESS | 5044 | RSS: Main: 167079936 02:17:59 INFO - PROCESS | 5044 | 02:18:01 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:18:02 INFO - PROCESS | 5044 | RSS: Main: 167215104 02:18:02 INFO - PROCESS | 5044 | 02:18:05 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:18:05 INFO - PROCESS | 5044 | RSS: Main: 167383040 02:18:05 INFO - PROCESS | 5044 | 02:18:08 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:18:09 INFO - PROCESS | 5044 | RSS: Main: 167268352 02:18:09 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | Cycle 1(1): loaded http://localhost:55045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55045/tests/kraken/driver.html?testName=ai-astar) 02:18:10 INFO - PROCESS | 5044 | RSS: Main: 167849984 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | __start_tp_report 02:18:10 INFO - PROCESS | 5044 | _x_x_mozilla_page_load 02:18:10 INFO - PROCESS | 5044 | _x_x_mozilla_page_load_details 02:18:10 INFO - PROCESS | 5044 | |i|pagename|runs| 02:18:10 INFO - PROCESS | 5044 | |0;ai-astar;113;104;110;109;112;111;110;109;110;109 02:18:10 INFO - PROCESS | 5044 | |1;audio-beat-detection;152;127;156;178;141;153;155;129;189;127 02:18:10 INFO - PROCESS | 5044 | |2;audio-dft;164;165;161;162;162;164;167;163;163;161 02:18:10 INFO - PROCESS | 5044 | |3;audio-fft;76;75;84;161;75;76;73;73;163;76 02:18:10 INFO - PROCESS | 5044 | |4;audio-oscillator;83;82;155;83;82;84;137;83;83;144 02:18:10 INFO - PROCESS | 5044 | |5;imaging-gaussian-blur;117;117;118;118;117;118;117;118;117;117 02:18:10 INFO - PROCESS | 5044 | |6;imaging-darkroom;146;148;147;147;147;147;146;146;147;145 02:18:10 INFO - PROCESS | 5044 | |7;imaging-desaturate;95;96;95;95;97;95;96;97;96;96 02:18:10 INFO - PROCESS | 5044 | |8;json-parse-financial;59;55;56;55;57;55;56;55;55;58 02:18:10 INFO - PROCESS | 5044 | |9;json-stringify-tinderbox;62;63;63;63;64;62;64;63;62;63 02:18:10 INFO - PROCESS | 5044 | |10;stanford-crypto-aes;83;86;78;79;82;80;82;80;110;84 02:18:10 INFO - PROCESS | 5044 | |11;stanford-crypto-ccm;124;130;136;128;123;117;128;140;134;127 02:18:10 INFO - PROCESS | 5044 | |12;stanford-crypto-pbkdf2;163;159;164;158;160;164;162;160;159;158 02:18:10 INFO - PROCESS | 5044 | |13;stanford-crypto-sha256-iterative;64;66;67;62;62;62;61;62;63;67 02:18:10 INFO - PROCESS | 5044 | __end_tp_report 02:18:10 INFO - PROCESS | 5044 | __start_cc_report 02:18:10 INFO - PROCESS | 5044 | _x_x_mozilla_cycle_collect,852 02:18:10 INFO - PROCESS | 5044 | __end_cc_report 02:18:10 INFO - PROCESS | 5044 | __startTimestamp1464340690964__endTimestamp 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | ------- Summary: start ------- 02:18:10 INFO - PROCESS | 5044 | Number of tests: 14 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.41 (2.2%) stddev-sans-first:2.24 02:18:10 INFO - PROCESS | 5044 | Values: 113.0 104.0 110.0 109.0 112.0 111.0 110.0 109.0 110.0 109.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:154.00 stddev:20.96 (13.6%) stddev-sans-first:22.23 02:18:10 INFO - PROCESS | 5044 | Values: 152.0 127.0 156.0 178.0 141.0 153.0 155.0 129.0 189.0 127.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.87 (1.1%) stddev-sans-first:1.96 02:18:10 INFO - PROCESS | 5044 | Values: 164.0 165.0 161.0 162.0 162.0 164.0 167.0 163.0 163.0 161.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.50 stddev:36.39 (48.2%) stddev-sans-first:38.06 02:18:10 INFO - PROCESS | 5044 | Values: 76.0 75.0 84.0 161.0 75.0 76.0 73.0 73.0 163.0 76.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:83.00 stddev:30.49 (36.7%) stddev-sans-first:31.58 02:18:10 INFO - PROCESS | 5044 | Values: 83.0 82.0 155.0 83.0 82.0 84.0 137.0 83.0 83.0 144.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:18:10 INFO - PROCESS | 5044 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 02:18:10 INFO - PROCESS | 5044 | Values: 146.0 148.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 145.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 02:18:10 INFO - PROCESS | 5044 | Values: 95.0 96.0 95.0 95.0 97.0 95.0 96.0 97.0 96.0 96.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.45 (2.6%) stddev-sans-first:1.09 02:18:10 INFO - PROCESS | 5044 | Values: 59.0 55.0 56.0 55.0 57.0 55.0 56.0 55.0 55.0 58.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 02:18:10 INFO - PROCESS | 5044 | Values: 62.0 63.0 63.0 63.0 64.0 62.0 64.0 63.0 62.0 63.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:82.00 stddev:9.31 (11.4%) stddev-sans-first:9.86 02:18:10 INFO - PROCESS | 5044 | Values: 83.0 86.0 78.0 79.0 82.0 80.0 82.0 80.0 110.0 84.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:129.00 stddev:6.72 (5.2%) stddev-sans-first:6.91 02:18:10 INFO - PROCESS | 5044 | Values: 124.0 130.0 136.0 128.0 123.0 117.0 128.0 140.0 134.0 127.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.36 (1.5%) stddev-sans-first:2.35 02:18:10 INFO - PROCESS | 5044 | Values: 163.0 159.0 164.0 158.0 160.0 164.0 162.0 160.0 159.0 158.0 02:18:10 INFO - PROCESS | 5044 | 02:18:10 INFO - PROCESS | 5044 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:2.27 (3.6%) stddev-sans-first:2.40 02:18:10 INFO - PROCESS | 5044 | Values: 64.0 66.0 67.0 62.0 62.0 62.0 61.0 62.0 63.0 67.0 02:18:10 INFO - PROCESS | 5044 | -------- Summary: end -------- 02:18:10 INFO - PROCESS | 5044 | 02:18:11 INFO - TEST-INFO | 5044: exit 0 02:18:11 INFO - TEST-OK | kraken | took 61736ms 02:18:11 INFO - SUITE-END | took 1173s 02:18:12 INFO - Completed test suite (00:19:33) 02:18:12 INFO - javascript benchmark 02:18:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7169.471980390015, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.646645635752, 3097.98451007745, 3158.3525377297656, 3198.4882418812995, 3206.134343727194, 5493.560515158788, 5505.174223866417, 5512.972435137824, 5574.358948720898, 5583.246261754662, 5378.623496355257, 5444.891102177954, 5516.724163791804, 5521.365043020054, 5523.447655234475, 4958.652894297392, 4990.975045124769, 5007.899842003158, 5086.821961231358, 5156.742162891859, 4982.103221420143, 5161.225816127592, 5179.663321884084, 5182.740862956856, 5190.351206099238, 4880.6095512358925, 4934.358533390672, 4960.454350021495, 5004.174311238641, 5012.8496145115705, 4963.354763880672, 4965.875853103666, 4968.478309777457, 4981.825636102755, 5023.974880125613, 4936.90126197474, 4942.382202224722, 4951.678140920829, 4953.306537084811, 5007.974960125212, 5268.972550352682, 5341.412444631087, 5398.217258497496, 5403.5136837684795, 5425.565954723613, 5928.7332070056955, 5929.644221346733, 5939.643621382731, 5947.464728174485, 5956.076808094752, 5871.089981052944, 5997.640141591519, 5998.550108741862, 6004.669743164124, 6007.7596896124105, 5497.120460726304, 5530.142827861688, 5551.611387202897, 5571.0, 5576.888462230773, 6070.332263451017, 6108.541859360477, 6109.75560977556, 6111.35830737775, 6127.601705889103, 5724.742386592613, 5783.537317014713, 5820.0, 5832.854178645568, 5839.445252700986, 5898.115282707542, 5902.586818922634, 5905.0, 5918.141869428909, 5967.37342579023, 5767.192593036978, 5796.101604251347, 5812.070068789058, 5863.736131874076, 5869.941300586939, 5855.0, 5878.412158784087, 5881.970590147107, 5886.117082437669, 5887.8233652990475, 4375.759333236702, 4383.1452866691325, 4405.801738921757, 4443.577860103285, 4466.642668586505, 3950.8419663213726, 3962.5443074046275, 3963.6829053675638, 3999.5000624921886, 4010.2380547695843, 5463.535599474009, 5624.156376543469, 5633.549316054706, 5642.322921249476, 5668.149777533321, 5880.176775251468, 5914.935311643945, 5930.762769489258, 5974.61165024272, 5988.9401105989255, 5586.050371436865, 5621.803236886771, 5627.662340259598, 5632.098864181793, 5645.153227015899, 4842.176829938919, 4906.852794416173, 4913.557779799835, 4935.16102262609, 4974.751262436864, 6105.481034112061, 6130.172426722335, 6199.070139479114, 6211.16149319836, 6223.96888015557, 5967.761289548543, 5969.462748352669, 5982.820515384633, 5998.760049598141, 6003.429674180946, 5962.880742385215, 5974.40255974399, 5996.160537524663, 6170.568060235741, 6178.66017369031, 5760.732638819453, 5764.337101233412, 5782.132680098019, 5786.479216870502, 5829.621074630136, 5839.35767065614, 5850.210221620197, 5856.267966504187, 5869.853253668522, 5876.44173803488, 5646.407127251744, 5702.230198923258, 5727.8568035799435, 5766.567507437043, 5807.157962095388, 5597.832065038056, 5702.258706368146, 5719.170720245458, 5719.771209151754, 5756.165356023437, 5696.088625819849, 5722.427757224411, 5725.2843394575675, 5729.0, 5748.913766293425, 5622.8313150605545, 5740.138979152994, 5798.188253644409, 5822.388649191774, 5873.735681894411, 5683.77264909399, 5719.48524632785, 5721.799737009184, 5733.082706766897, 5733.885322293448], "value": 5426.330032071753, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.128307538692, 612.5803824380298, 637.3212528656977, 638.9584976488323, 659.6371995402527, 38853.22293554131, 42785.78607106964, 42999.570004299945, 43020.354694679605, 43102.353464698055, 43526.12947741051, 43564.12871742571, 44146.7792661037, 44154.0, 44261.557384426145, 8493.532855692934, 8568.485890846538, 8651.48091114532, 8669.21977022068, 8684.0, 8561.828763424728, 8676.436031657953, 8729.214370706635, 8738.300935925143, 8739.4756314621, 8713.041565427799, 8757.737267881974, 8765.7808554786, 8783.692570760024, 8790.077041910603, 8674.826503469958, 8715.782105447382, 8727.95636021819, 8735.432196907244, 8775.517346545937, 8526.190011948855, 8675.349348798802, 8683.826323473495, 8727.258183054448, 8730.432521886121, 40930.158142883345, 41011.0, 41065.79467102675, 41192.58807411917, 41316.0, 3492.2142517933517, 3517.067976986101, 3609.386404311247, 3633.8364773585254, 4017.5178978522763, 32002.0, 32283.31538430844, 32288.838555807306, 32703.345933081204, 33242.83378583092, 4341.565843415665, 4434.645228381722, 4440.689151759379, 4507.842225522124, 4607.9308810367875, 353027.0, 353892.99999999744, 355455.0, 357115.0, 357415.0, 34305.48541771875, 35316.64683353185, 35389.292214155575, 59017.40982590119, 59367.70316148478, 36862.0, 36869.446958295644, 37045.44431833525, 37045.81477092597, 37065.444018339746, 14036.508722194674, 14265.857341426452, 14317.64205894861, 14351.067180633225, 14351.928240358731, 11006.284591501688, 11080.501377438035, 11089.722756931142, 11100.888991110147, 11112.277701949348, 8263.380246481538, 8319.126491718403, 8343.207395297559, 8434.156584341517, 8434.873476897852, 3235.902922912316, 3264.5756051713124, 3288.194392373836, 3296.258341873059, 3319.6016478022307, 1027.2347101409498, 1065.8241390170535, 1075.5912753153907, 1141.57191053355, 1223.149910811995, 32449.675503244664, 32705.0, 32722.181945451077, 33192.17019574482, 33559.83220083884, 1138.2658185470325, 1139.6239241050598, 1150.7871043856746, 1232.1744431231098, 1274.6558429224058, 17184.0, 17233.482995510156, 17317.56706082358, 17389.304427822746, 17516.12419379026, 533984.0, 537273.0, 537950.0, 540059.0, 540948.0, 58709.70645146832, 58930.70534647385, 59166.70416647889, 59474.0, 59585.0, 1327.3429652322163, 1337.3914868734703, 1385.6189547874415, 1387.1538361599416, 1392.7910813378073, 31180.688193117778, 31527.0, 31632.367352652356, 31732.20669483189, 32471.350572987936, 51689.0, 51792.48207517876, 52015.73992130015, 52081.47918520766, 52164.478355215964, 317257.0, 322600.0, 325281.0, 328221.0, 328610.0, 27566.448671026064, 27864.86067569649, 27906.16281511558, 27953.0, 28029.859850700617, 47139.528604713516, 48161.0, 48569.271460927404, 48572.2714159295, 49543.50456495533, 40783.38491546189, 41274.0, 41775.373369398876, 41977.0, 42570.0, 40661.79669101635, 41475.0, 41768.95577610584, 41977.0, 41995.58004420039, 41020.79489602533, 42183.0, 42592.5740742601, 42664.78667606642, 42712.0, 35710.46434303436, 36565.45151822671, 36725.81637091797, 37089.44365834461, 37575.43636845395, 28712.0, 28819.27951801138, 28839.7116028837, 28914.566281505373, 29229.561556576242], "value": 18676.860450020078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.936485479896, 390.05995550722747, 395.0814356620857, 395.78429755783094, 405.37976895350107, 18086.276548938025, 19230.90384548079, 19861.60276794465, 19882.801171988274, 20059.398218053444, 18387.816121838776, 18551.536211594717, 19057.332993345237, 19241.0, 19327.806721932775, 5401.972990135054, 5446.2647542581835, 5551.8889622207735, 5860.794872179475, 5869.647821130725, 5656.208130861683, 5780.884382312352, 5799.304083509985, 5800.419958004208, 5814.24414826072, 5553.222548843165, 5697.173909783079, 5713.942860571383, 5765.596408251424, 5772.971135144339, 5728.140778883159, 5729.541636669056, 5746.396628354046, 5753.309602847664, 5754.338251101114, 4961.131801934647, 5234.319538459976, 5267.9736601316745, 5354.491323324278, 5361.544268737162, 13404.664883377896, 13539.187648741106, 13849.0, 13860.306984650828, 13884.23636699981, 2285.108807565051, 2295.4490922178725, 2355.0344358812804, 2396.424858034077, 2516.245126462054, 10255.589776408935, 10495.527701253386, 11722.94138529302, 11827.526898924032, 14990.250487475583, 1936.8256856882808, 2001.9199232030846, 2018.5559176981042, 2019.363900371393, 2031.1976769176092, 82045.17954820435, 82486.0, 82904.58547707283, 82937.17062829355, 83218.58390708007, 10780.568777248822, 10832.295900766425, 11046.502907369188, 11076.501557429934, 11213.439328033566, 15333.463328783662, 15360.231988400536, 15399.384024638888, 15430.0, 15448.922755386151, 7540.208278130827, 7698.730544430918, 7794.649240784178, 7823.295903368724, 8042.396820238506, 7084.716611335489, 7138.179109402381, 7187.748428804966, 7215.927840721631, 7321.158066822383, 4674.158651442705, 4688.320193571913, 4698.694584851974, 4732.645051621143, 4872.4153101628035, 1939.3406241877829, 1968.8523360747715, 1980.821726044663, 1991.312997016027, 2000.6998950157301, 893.1738142218422, 977.022977022977, 994.194702291132, 1029.953652085658, 1030.6701855406197, 17566.0, 18370.540736481697, 19464.902675486534, 19525.121369538403, 19562.413127606196, 941.4727752458645, 951.6193522591019, 954.8997355277735, 984.2863923655435, 1032.5921261101823, 10067.748306292402, 10799.0, 10829.512671929782, 10858.2399232053, 10891.400972946563, 457457.0, 469397.0, 497828.0, 499858.0, 504660.0, 53381.733091335074, 70219.64890175516, 94502.0, 94928.0, 97859.51070244603, 958.9760255993656, 961.8557216417454, 985.5959056786826, 996.0935548650693, 1003.7641154328727, 17621.383251586132, 17932.28270869203, 18001.54996125055, 18051.909740451214, 18323.0, 40494.392584111854, 40888.79555602322, 41493.54772582945, 42631.0, 42684.359734603386, 56061.43938560562, 56467.0, 57082.0, 57674.4232557669, 58095.0, 6911.688973996082, 7607.581583012766, 8357.582120894052, 8388.454750441202, 8891.110888911056, 12895.742085158432, 12972.870271297166, 13246.20522768637, 13477.19136851792, 13588.728225435238, 11233.269837460539, 11428.514303137623, 11437.59968401102, 11914.821277681016, 11942.16404851652, 9147.862782058408, 11383.943080284545, 11429.371384573597, 11535.538578457103, 11688.298702077902, 11833.290002599872, 11935.0, 11965.222260553384, 12022.63932082039, 12216.0, 8683.609237584198, 8685.198799848917, 8697.08680588529, 8788.560571971504, 8821.294296456397, 11171.553137874394, 12078.939605301917, 12247.510099596273, 12307.32309722938, 12415.503379864704], "value": 9030.599689285147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.391447549267, 1516.772484127381, 1671.7492376143578, 1794.0581194872698, 1813.4287699374704, 8135.7152499662525, 8943.55282235888, 9018.09819018098, 9426.151646351835, 9464.0, 8648.69729559464, 8889.066648001964, 8941.776455588613, 8942.239909607692, 8993.865092023625, 2332.1604222479937, 2366.7278262999716, 2368.751281115484, 2375.4536456614987, 2381.5832229359794, 2322.6167682332393, 2325.2559181062065, 2364.6925899633025, 2373.5134297468976, 2379.7144342678816, 2360.0913648245464, 2361.515889242701, 2378.167641325531, 2380.92857214283, 2382.845115067515, 2274.0449011415244, 2274.920377786778, 2279.1225378229337, 2280.5096904165603, 2330.1727886600183, 2256.029907139929, 2266.5240299537118, 2268.8184945204343, 2282.897269622871, 2284.3603790938396, 9270.953645231799, 9327.20718738908, 9350.392224505453, 9361.90638093624, 9370.85943710845, 5171.0, 5294.576433885319, 5297.364316282033, 5298.231756395339, 5310.92033619496, 3110.7200351968204, 3170.8097514149226, 3265.7387409007224, 3280.9835950820093, 3287.4247006773717, 956.9186619137382, 962.1581116523042, 977.5796407544752, 1020.739711373595, 1027.0140664961646, 13094.0, 13130.474781008748, 13152.605421837361, 13215.0, 13238.735225295537, 4425.845095421645, 4585.426821647294, 4636.327732478771, 4651.348811166439, 4654.743989080565, 11136.554537818396, 11198.776024479628, 11203.271787333797, 11204.047655949173, 11265.774684506265, 5339.652922560099, 5352.170413585901, 5379.35447746273, 5398.64908780928, 5407.324084489439, 4267.615914567704, 4693.882652933636, 4847.200211965057, 4850.805967761321, 4981.153203955337, 3877.554081280689, 3908.120672848643, 3997.420374045747, 4005.839766409369, 4007.6393124618926, 1195.8937982366276, 1197.1859135787574, 1197.658667279821, 1197.7544603356291, 1199.9700007499707, 820.5363969357294, 913.5067063785482, 932.077243528915, 965.5124162298135, 978.9559469823876, 6093.238345206849, 6206.193194884636, 6231.22109736283, 6341.746330146742, 6382.904256436157, 947.5735918836414, 969.8739163908647, 1020.403064207447, 1020.4132623741378, 1023.7594165371132, 4087.2642924273914, 4136.73111247774, 4174.415581818548, 4176.665866730715, 4230.302000169999, 11675.766484670428, 11899.583514576949, 11984.221025633306, 12005.63983080509, 12049.51801927913, 11606.593769218205, 11842.526298947945, 11887.821682674767, 11902.285862848257, 11909.344986025679, 8326.29226515753, 8716.346274029473, 8740.95629521861, 8929.196372326522, 8939.955300223457, 6422.935770642233, 6542.738290468328, 6599.142111525471, 6673.099131617169, 6728.529002969745, 10632.25574209798, 10848.403337816495, 11050.115990720884, 11095.72260693489, 11160.162987775788, 10960.451977401257, 11116.388598627153, 11116.944415277872, 11128.332300062022, 11128.499217535069, 7527.924720752722, 8194.959025204837, 8291.461055031645, 8337.791555211168, 8739.475631462132, 8800.0, 9002.369834111549, 9056.954715226646, 9108.043655416086, 9136.63453461854, 7765.689372425039, 7895.64469598858, 7919.683212671659, 7959.920400795918, 8137.715179968673, 7960.681572737026, 7971.282584567417, 8040.557769322743, 8171.7548473545885, 8183.427160098736, 7163.426925845815, 7272.927270727437, 7292.380147687506, 7329.267073292628, 7607.505512141693, 5254.238135470259, 5420.4850539198715, 5428.83713488596, 5534.52956498686, 5664.971675141598, 5059.797608095635, 5455.8363249102595, 5560.7219639018695, 5718.256626638677, 5787.826365209051], "value": 4779.889507796077, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.6578885598278, 308.577249168639, 309.8342386823049, 328.14518180140726, 330.1910319716694, 5484.561235101192, 5541.972290138554, 5554.611177217596, 5580.8280261145155, 5668.433156684335, 5559.527440167591, 5577.44225577442, 5581.972090139554, 5606.046972014757, 5615.466530679589, 4277.0, 4304.041661044217, 4334.501532323776, 4348.086901750628, 4349.151915376503, 4074.103697186614, 4305.4715575970395, 4325.913481730364, 4347.347897815322, 4379.4525684289465, 4224.302990006645, 4245.617894389505, 4270.124624451995, 4292.270314046619, 4300.956990430087, 4154.356074808409, 4257.340112282601, 4273.18809426208, 4273.615374616299, 4273.7008409411355, 3732.346839303111, 3732.608076151992, 3735.62643735627, 3738.12154143776, 3754.643308885679, 5345.3585569731495, 5353.0, 5372.247885296062, 5388.407275199725, 5389.622726409153, 4763.737994410306, 4881.535539338184, 4944.87637809054, 4967.4784147664695, 4991.201407774775, 5821.9811532981985, 5866.882662346772, 5897.970510147465, 5898.254608323702, 5910.615809972338, 4060.167665628539, 4109.178164367138, 4120.979395103005, 4121.5878412158845, 4139.9793001035105, 5888.499477544414, 6080.391960803929, 6081.726322315506, 6123.601965872204, 6125.356837532039, 4097.282975479279, 4136.958630413657, 4141.4409054777825, 4143.150654115899, 4144.937825932613, 4170.874873753793, 4186.246475634415, 4187.413762073312, 4191.7484950903045, 4199.601037901394, 4791.257355109963, 4849.951500485021, 4855.271709243571, 4875.34182885313, 4885.5847252983895, 5680.4319568042865, 5858.209141765892, 5882.382349853289, 5909.8227053188475, 5921.348651648315, 1463.3488097796592, 1467.8844078500417, 1469.8608578351864, 1478.9408423663149, 1485.762278035509, 876.8553188723916, 895.1272509303377, 896.9551522423852, 902.7201567514091, 914.3553794574809, 5030.503799859136, 5035.244713293036, 5042.722650254198, 5047.520485553867, 5082.796688132434, 5320.973395133077, 5433.510984011458, 5437.945620543744, 5457.508824205841, 5458.317710286215, 5043.52086551777, 5047.697138171721, 5112.71880046601, 5258.7370631468275, 5689.203511508392, 3206.8717251310154, 3210.8234047127166, 3223.6131664200448, 3250.5449237106823, 3251.1143536748627, 6055.333913269536, 6150.50795936324, 6237.376262373727, 6244.751889319841, 6265.778173256172, 6157.96921015392, 6170.598911070766, 6171.259448866075, 6174.938250617526, 6190.288116866528, 6202.906956395657, 6236.282827474898, 6252.218472690914, 6269.529785266123, 6273.278572964167, 5787.2187254720075, 6018.578699490994, 6037.366076561898, 6044.879102418015, 6047.909281360695, 5932.525397968066, 6027.246594175728, 6049.153118563317, 6110.358412366638, 6122.265328160649, 5997.250343707036, 6207.782727604512, 6270.968645156928, 6285.842853928689, 6318.778842740482, 4193.664506839506, 4216.0, 4217.093324935154, 4228.2600544905135, 4231.894202644959, 5863.941360586339, 5872.618279811799, 6055.212822333068, 6080.391960803884, 6137.539684523768, 5825.679587622722, 5848.2689663792025, 5861.677607731615, 5878.823635290948, 5926.525877929669, 5921.6743079131065, 5935.792247271324, 5937.228160339128, 5943.940560594512, 5954.910676339945, 5556.666600004012, 5716.228309178207, 5764.913526297025, 5810.767569297181, 5828.825135245949, 5884.58807883444, 5921.822345329647, 5944.375840536682, 5950.375210602998, 5955.583109182489, 5659.320881494247, 5695.914561281501, 5750.9424905752085, 5797.159411885337, 5807.954568177768], "value": 4387.656920340089, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.5390058163938, 773.2885745114494, 784.0, 842.6797816829605, 848.7665891879732, 14806.851931480682, 15723.528294151194, 15799.368025279004, 15819.367225310974, 15843.920780396096, 14376.49682261121, 14442.205678687667, 14458.710825783504, 14481.493147739831, 14543.054701444398, 669.8057563306635, 807.0920214758382, 820.0774129104757, 821.2977903892175, 821.8602837517636, 790.8734602463607, 802.618756090858, 806.5402720449317, 807.5074204735107, 808.0626473290984, 852.5651917522077, 858.6393714639867, 859.4843094143527, 860.3762272352526, 863.0377129500624, 847.7456762971084, 850.3324889961351, 851.6635928808117, 853.4324674091722, 857.0615176381914, 624.356912380249, 624.9125122482856, 626.7054484392328, 627.1345543150469, 628.6322501336723, 13158.407871645799, 13224.801627975588, 13276.0, 13293.20240785556, 13310.134841235289, 13730.588082357544, 13914.51299204523, 14271.215083170422, 14524.128552286897, 14570.125792452487, 11748.647540573797, 11871.109666775026, 11899.940500297529, 11905.226160299639, 12045.457954392074, 3767.472553842464, 3808.485854409647, 3844.480995065658, 3879.8836034919, 3947.486826712509, 58941.0, 59027.704861475846, 59110.40889591092, 59126.40873591295, 59155.0, 10937.28907621018, 11246.887531124748, 11423.543058277575, 11462.083033357312, 11462.828057579143, 20847.1661133556, 21045.26341578068, 21051.78948210498, 21137.0, 21141.89429052845, 8364.53995030267, 8374.143485502833, 8534.103919088531, 8572.957135214285, 8586.356023298278, 4589.5639914208095, 4724.598409135193, 4733.100710864925, 4796.160671882476, 4807.326974223612, 3628.818559072036, 3655.8720444784835, 3718.1262403335195, 3725.8509659613856, 3748.2503499299705, 612.6599737145838, 629.0721186250336, 648.2659879096439, 663.3896814930275, 665.9367360100782, 627.3130921640796, 687.4466054825913, 746.7535713214626, 754.1289810269147, 755.4634420306027, 9501.572429240563, 9747.902520974842, 9913.454759988126, 10078.546465409074, 10169.593216271267, 692.6933312070893, 735.9742409015658, 739.548875186136, 744.4836452789536, 754.8603508350973, 4673.789679464432, 4862.246351815475, 4864.294677271847, 4867.829625963145, 4877.902441951142, 69727.65136174287, 70730.0, 71140.28859711337, 71290.0, 72813.27186728171, 56067.0, 57877.71061144752, 64198.35801642017, 64734.35265647378, 65504.344956550776, 56726.7163664179, 57305.0, 57451.13823292654, 58668.0, 59702.701486493155, 9773.804523909339, 9878.802423951336, 10085.647002354883, 10126.0, 10134.746631334276, 35357.292854143285, 35949.0, 36325.45511817272, 38313.0, 39478.2104357917, 49085.0, 49398.753006234736, 49546.752266238436, 49661.25508117453, 50644.49355506545, 12075.637730868088, 12146.392680366123, 12339.321337326533, 12846.67883302925, 12895.274768242449, 14044.719105617625, 14312.785308220176, 14582.781258280922, 14594.270286485846, 14878.851211487747, 13380.330983450984, 13557.59327220185, 13616.591502254949, 13712.245826479639, 14104.435822566982, 12692.809607855705, 12841.871581284067, 13091.738165236451, 13214.173628442812, 14097.859021409655, 12989.0, 13022.348882556023, 13037.15258508194, 13265.137766045176, 13826.170429774245, 10848.728781780203, 11083.334999900031, 11302.943485282522, 11537.480813363587, 11541.0, 10752.784944301227, 11236.494357753758, 11281.830772538255, 11397.715057123638, 11405.600803971822], "value": 7074.678351935958, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 110.0, 109.0, 112.0, 111.0, 110.0, 109.0, 110.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 156.0, 178.0, 141.0, 153.0, 155.0, 129.0, 189.0, 127.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 161.0, 162.0, 162.0, 164.0, 167.0, 163.0, 163.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 84.0, 161.0, 75.0, 76.0, 73.0, 73.0, 163.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 155.0, 83.0, 82.0, 84.0, 137.0, 83.0, 83.0, 144.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 56.0, 55.0, 57.0, 55.0, 56.0, 55.0, 55.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 64.0, 62.0, 64.0, 63.0, 62.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 78.0, 79.0, 82.0, 80.0, 82.0, 80.0, 110.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 136.0, 128.0, 123.0, 117.0, 128.0, 140.0, 134.0, 127.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 164.0, 158.0, 160.0, 164.0, 162.0, 160.0, 159.0, 158.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 67.0, 62.0, 62.0, 62.0, 61.0, 62.0, 63.0, 67.0], "value": 63.6, "unit": "score"}]}]} 02:18:12 INFO - Return code: 0 02:18:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:18:12 ERROR - # TBPL SUCCESS # 02:18:12 INFO - Running post-action listener: _resource_record_post_action 02:18:12 INFO - ##### 02:18:12 INFO - ##### Finished run-tests step (success) 02:18:12 INFO - ##### 02:18:12 INFO - Running post-run listener: _resource_record_post_run 02:18:12 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 438272; Write bytes: 286773248; Read time: 224; Write time: 188368 02:18:12 INFO - TinderboxPrint: CPU usage
13.4% 02:18:12 INFO - TinderboxPrint: I/O read bytes / time
438,272 / 224 02:18:12 INFO - TinderboxPrint: I/O write bytes / time
286,773,248 / 188,368 02:18:12 INFO - TinderboxPrint: CPU idle
8,223.9 (86.5%) 02:18:12 INFO - TinderboxPrint: CPU user
1,224.0 (12.9%) 02:18:12 INFO - TinderboxPrint: Swap in / out
0 / 0 02:18:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1269760; Read time: 0; Write time: 72 02:18:12 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 438272; Write bytes: 285503488; Read time: 224; Write time: 188296 02:18:12 INFO - Running post-run listener: _upload_blobber_files 02:18:12 INFO - Blob upload gear active. 02:18:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:18:12 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 02:18:12 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:18:12 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:18:13 INFO - (blobuploader) - INFO - Open directory for files ... 02:18:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:18:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:17 INFO - (blobuploader) - INFO - Done attempting. 02:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:18:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:19 INFO - (blobuploader) - INFO - Done attempting. 02:18:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:18:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:18:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:20 INFO - (blobuploader) - INFO - Done attempting. 02:18:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:18:20 INFO - Return code: 0 02:18:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:18:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:18:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/063297a9a5ab0cb3d55b6458435ec060af4f7326bc94da9a7b8ec22d1c5f35c4e8c04d0e4ce3cdc6bf4d65f5fe5acf6cfe5b2861f0547d3a8d686b9a1faa5719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fa17bae0997986d51d6ae520ed451fbe92f982da78d40f4dcbc8601152c6aefa1dbf81f249c1f12887b2d4f593cadfb213da392c7fd2acd7c9feb7958be1d1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2deb3fc0aaefe77b1cce4c35b3ddc3dca527f9a356ce89a80b235609438e22a28a0cc2fefe1fa20a7c75cb26f128c63d1573b07b61d25bf5487f1f45d291899d"} 02:18:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:18:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:18:20 INFO - Contents: 02:18:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/063297a9a5ab0cb3d55b6458435ec060af4f7326bc94da9a7b8ec22d1c5f35c4e8c04d0e4ce3cdc6bf4d65f5fe5acf6cfe5b2861f0547d3a8d686b9a1faa5719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fa17bae0997986d51d6ae520ed451fbe92f982da78d40f4dcbc8601152c6aefa1dbf81f249c1f12887b2d4f593cadfb213da392c7fd2acd7c9feb7958be1d1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2deb3fc0aaefe77b1cce4c35b3ddc3dca527f9a356ce89a80b235609438e22a28a0cc2fefe1fa20a7c75cb26f128c63d1573b07b61d25bf5487f1f45d291899d"} 02:18:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:18:20 INFO - Copying logs to upload dir... 02:18:20 INFO - mkdir: /builds/slave/test/build/upload/logs 02:18:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.297422 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-27 02:18:20.178909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 02:18:20.183063) ========= 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=cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/063297a9a5ab0cb3d55b6458435ec060af4f7326bc94da9a7b8ec22d1c5f35c4e8c04d0e4ce3cdc6bf4d65f5fe5acf6cfe5b2861f0547d3a8d686b9a1faa5719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fa17bae0997986d51d6ae520ed451fbe92f982da78d40f4dcbc8601152c6aefa1dbf81f249c1f12887b2d4f593cadfb213da392c7fd2acd7c9feb7958be1d1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2deb3fc0aaefe77b1cce4c35b3ddc3dca527f9a356ce89a80b235609438e22a28a0cc2fefe1fa20a7c75cb26f128c63d1573b07b61d25bf5487f1f45d291899d"} build_url:https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/cW_LBl-lSdKntAggwBDQvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/063297a9a5ab0cb3d55b6458435ec060af4f7326bc94da9a7b8ec22d1c5f35c4e8c04d0e4ce3cdc6bf4d65f5fe5acf6cfe5b2861f0547d3a8d686b9a1faa5719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fa17bae0997986d51d6ae520ed451fbe92f982da78d40f4dcbc8601152c6aefa1dbf81f249c1f12887b2d4f593cadfb213da392c7fd2acd7c9feb7958be1d1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2deb3fc0aaefe77b1cce4c35b3ddc3dca527f9a356ce89a80b235609438e22a28a0cc2fefe1fa20a7c75cb26f128c63d1573b07b61d25bf5487f1f45d291899d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 02:18:20.209311) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:18:20.209673) ========= 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=cbe409c6de289db6ac707de3000001d4-1464335239.743974-93578956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:18:20.294164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 02:18:20.294500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 02:18:20.294787) ========= ========= Total master_lag: 0.18 =========