builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1464934634.75 results: success (0) buildid: 20160602203047 builduid: f14de5b1fbc64e2290f9f771eb8054cf revision: 0c48702e8ff4cf427e443ed91630465c39f6c4ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:14.754244) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:14.755726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:14.756075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:14.804901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:14.808791) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 23:17:15-- 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% 33.4M=0s 2016-06-02 23:17:15 (33.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:14.951262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:14.951566) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014715 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:15.005266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:15.005593) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c48702e8ff4cf427e443ed91630465c39f6c4ee --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 0c48702e8ff4cf427e443ed91630465c39f6c4ee --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=a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 23:17:15,670 truncating revision to first 12 chars 2016-06-02 23:17:15,670 Setting DEBUG logging. 2016-06-02 23:17:15,670 attempt 1/10 2016-06-02 23:17:15,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c48702e8ff4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 23:17:16,154 unpacking tar archive at: fx-team-0c48702e8ff4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.813896 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:15.834612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:15.835143) ========= script_repo_revision: 0c48702e8ff4cf427e443ed91630465c39f6c4ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:15.835765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:15.836199) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 23:17:15.847010) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-02 23:17:15.847375) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:17:16 INFO - MultiFileLogger online at 20160602 23:17:16 in /builds/slave/test 23:17:16 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 23:17:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:17:16 INFO - {'append_to_log': False, 23:17:16 INFO - 'base_work_dir': '/builds/slave/test', 23:17:16 INFO - 'blob_upload_branch': 'Fx-Team', 23:17:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:17:16 INFO - 'branch': 'Fx-Team', 23:17:16 INFO - 'buildbot_json_path': 'buildprops.json', 23:17:16 INFO - 'config_files': ('talos/linux_config.py',), 23:17:16 INFO - 'default_actions': ('clobber', 23:17:16 INFO - 'read-buildbot-config', 23:17:16 INFO - 'download-and-extract', 23:17:16 INFO - 'populate-webroot', 23:17:16 INFO - 'create-virtualenv', 23:17:16 INFO - 'install', 23:17:16 INFO - 'run-tests'), 23:17:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:17:16 INFO - 'download_minidump_stackwalk': True, 23:17:16 INFO - 'download_symbols': 'ondemand', 23:17:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:17:16 INFO - 'tooltool.py': '/tools/tooltool.py', 23:17:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:17:16 INFO - '/tools/misc-python/virtualenv.py')}, 23:17:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:17:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:17:16 INFO - 'installer_path': 'installer.exe', 23:17:16 INFO - 'log_level': 'info', 23:17:16 INFO - 'log_name': 'talos', 23:17:16 INFO - 'log_to_console': True, 23:17:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:17:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:17:16 INFO - 'opt_config_files': (), 23:17:16 INFO - 'pip_index': False, 23:17:16 INFO - 'sps_profile': False, 23:17:16 INFO - 'sps_profile_interval': 0, 23:17:16 INFO - 'suite': 'dromaeojs-e10s', 23:17:16 INFO - 'system_bits': '32', 23:17:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:17:16 INFO - 'title': 'talos-linux64-ix-062', 23:17:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:17:16 INFO - 'use_talos_json': True, 23:17:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:17:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:17:16 INFO - 'work_dir': 'build'} 23:17:16 INFO - ##### 23:17:16 INFO - ##### Running clobber step. 23:17:16 INFO - ##### 23:17:16 INFO - Running pre-action listener: _resource_record_pre_action 23:17:16 INFO - Running main action method: clobber 23:17:16 INFO - rmtree: /builds/slave/test/build 23:17:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:17:17 INFO - Running post-action listener: _resource_record_post_action 23:17:17 INFO - ##### 23:17:17 INFO - ##### Finished clobber step (success) 23:17:17 INFO - ##### 23:17:17 INFO - ##### 23:17:17 INFO - ##### Running read-buildbot-config step. 23:17:17 INFO - ##### 23:17:17 INFO - Running pre-action listener: _resource_record_pre_action 23:17:17 INFO - Running main action method: read_buildbot_config 23:17:17 INFO - Using buildbot properties: 23:17:17 INFO - { 23:17:17 INFO - "project": "", 23:17:17 INFO - "product": "firefox", 23:17:17 INFO - "script_repo_revision": "production", 23:17:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:17:17 INFO - "repository": "", 23:17:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:17:17 INFO - "buildid": "20160602203047", 23:17:17 INFO - "pgo_build": "True", 23:17:17 INFO - "basedir": "/builds/slave/test", 23:17:17 INFO - "buildnumber": 525, 23:17:17 INFO - "slavename": "talos-linux64-ix-062", 23:17:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:17:17 INFO - "platform": "ubuntu64_hw", 23:17:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:17:17 INFO - "branch": "fx-team", 23:17:17 INFO - "repo_path": "integration/fx-team", 23:17:17 INFO - "revision": "0c48702e8ff4cf427e443ed91630465c39f6c4ee", 23:17:17 INFO - "stage_platform": "linux64-pgo", 23:17:17 INFO - "builduid": "f14de5b1fbc64e2290f9f771eb8054cf", 23:17:17 INFO - "slavebuilddir": "test" 23:17:17 INFO - } 23:17:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:17:17 INFO - Running post-action listener: _resource_record_post_action 23:17:17 INFO - ##### 23:17:17 INFO - ##### Finished read-buildbot-config step (success) 23:17:17 INFO - ##### 23:17:17 INFO - ##### 23:17:17 INFO - ##### Running download-and-extract step. 23:17:17 INFO - ##### 23:17:17 INFO - Running pre-action listener: _resource_record_pre_action 23:17:17 INFO - Running main action method: download_and_extract 23:17:17 INFO - mkdir: /builds/slave/test/build/tests 23:17: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')]} 23:17:17 INFO - https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:22 INFO - Downloaded 1361 bytes. 23:17:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:17:22 INFO - Using the following test package requirements: 23:17:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:17:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:17:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:17:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:22 INFO - u'jsshell-linux-x86_64.zip'], 23:17:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:17:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:17:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:17:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:17:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:17:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:17:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:17:22 INFO - https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:17:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:17:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:17:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:27 INFO - Downloaded 24439630 bytes. 23:17:27 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'] 23:17:27 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 23:17:28 INFO - Return code: 0 23:17:28 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 23:17:28 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')]} 23:17:28 INFO - https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:29 INFO - Downloaded 24439630 bytes. 23:17:29 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'] 23:17:29 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 23:17:31 INFO - Return code: 0 23:17:31 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')]} 23:17:31 INFO - https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:32 INFO - Downloaded 10834055 bytes. 23:17:32 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'] 23:17:32 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 23:17:32 INFO - Return code: 0 23:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:32 INFO - https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:17:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:17:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:17:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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 23:17:35 INFO - Downloaded 59061401 bytes. 23:17:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:17:35 INFO - mkdir: /builds/slave/test/properties 23:17:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:17:35 INFO - Writing to file /builds/slave/test/properties/build_url 23:17:35 INFO - Contents: 23:17:35 INFO - build_url:https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:17:35 INFO - Running post-action listener: _resource_record_post_action 23:17:35 INFO - Running post-action listener: set_extra_try_arguments 23:17:35 INFO - ##### 23:17:35 INFO - ##### Finished download-and-extract step (success) 23:17:35 INFO - ##### 23:17:35 INFO - ##### 23:17:35 INFO - ##### Running populate-webroot step. 23:17:35 INFO - ##### 23:17:35 INFO - Running pre-action listener: _resource_record_pre_action 23:17:35 INFO - Running main action method: populate_webroot 23:17:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:17:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:17:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:17:35 INFO - '--tppagecycles', 23:17:35 INFO - '7'], 23:17:35 INFO - 'tests': ['tsvgm']}}, 23:17:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:17:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:17:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:17:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:17:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:35 INFO - 'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:17:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:17:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:35 INFO - 'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['damp', 'tps']}, 23:17:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:35 INFO - 'tests': ['damp', 'tps']}, 23:17:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['dromaeo_dom']}, 23:17:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:17:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['a11yr', 23:17:35 INFO - 'ts_paint', 23:17:35 INFO - 'tpaint', 23:17:35 INFO - 'sessionrestore', 23:17:35 INFO - 'sessionrestore_no_auto_restore', 23:17:35 INFO - 'tabpaint']}, 23:17:35 INFO - 'other-e10s': {'tests': ['a11yr', 23:17:35 INFO - 'ts_paint', 23:17:35 INFO - 'tpaint', 23:17:35 INFO - 'sessionrestore', 23:17:35 INFO - 'sessionrestore_no_auto_restore', 23:17:35 INFO - 'tabpaint']}, 23:17:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:17:35 INFO - 'ts_paint', 23:17:35 INFO - 'tpaint', 23:17:35 INFO - 'sessionrestore', 23:17:35 INFO - 'sessionrestore_no_auto_restore', 23:17:35 INFO - 'tabpaint']}, 23:17:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:17:35 INFO - 'ts_paint', 23:17:35 INFO - 'tpaint', 23:17:35 INFO - 'sessionrestore', 23:17:35 INFO - 'sessionrestore_no_auto_restore', 23:17:35 INFO - 'tabpaint']}, 23:17:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['a11yr', 23:17:35 INFO - 'ts_paint', 23:17:35 INFO - 'tpaint', 23:17:35 INFO - 'sessionrestore', 23:17:35 INFO - 'sessionrestore_no_auto_restore', 23:17:35 INFO - 'tabpaint']}, 23:17:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['a11yr', 23:17:35 INFO - 'ts_paint', 23:17:35 INFO - 'tpaint', 23:17:35 INFO - 'sessionrestore', 23:17:35 INFO - 'sessionrestore_no_auto_restore', 23:17:35 INFO - 'tabpaint']}, 23:17:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['tsvgx', 23:17:35 INFO - 'tsvgr_opacity', 23:17:35 INFO - 'tart', 23:17:35 INFO - 'tscrollx', 23:17:35 INFO - 'cart']}, 23:17:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:17:35 INFO - 'tsvgr_opacity', 23:17:35 INFO - 'tart', 23:17:35 INFO - 'tscrollx', 23:17:35 INFO - 'cart']}, 23:17:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:35 INFO - 'talos_options': ['--disable-e10s'], 23:17:35 INFO - 'tests': ['tp5o']}, 23:17:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:35 INFO - 'tests': ['tp5o']}, 23:17:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:35 INFO - 'talos_options': ['--disable-e10s', 23:17:35 INFO - '--xperf_path', 23:17:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:17:35 INFO - 'tests': ['tp5n']}, 23:17:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:35 INFO - 'talos_options': ['--xperf_path', 23:17:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:17:35 INFO - 'tests': ['tp5n']}}, 23:17:35 INFO - 'talos.zip': {'path': '', 23:17:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:17:35 INFO - Running post-action listener: _resource_record_post_action 23:17:35 INFO - ##### 23:17:35 INFO - ##### Finished populate-webroot step (success) 23:17:35 INFO - ##### 23:17:35 INFO - ##### 23:17:35 INFO - ##### Running create-virtualenv step. 23:17:35 INFO - ##### 23:17:35 INFO - Running pre-action listener: _resource_record_pre_action 23:17:35 INFO - Running main action method: create_virtualenv 23:17:35 INFO - Creating virtualenv /builds/slave/test/build/venv 23:17:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:17:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:17:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:17:35 INFO - Using real prefix '/usr' 23:17:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:17:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:17:38 INFO - Installing pip.................done. 23:17:38 INFO - Return code: 0 23:17:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:17:38 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')]} 23:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:38 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')]} 23:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:38 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 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:17:38 INFO - Using env: {'DISPLAY': ':0', 23:17:38 INFO - 'HOME': '/home/cltbld', 23:17:38 INFO - 'LANG': 'en_US.UTF-8', 23:17:38 INFO - 'LANGUAGE': 'en_US:en', 23:17:38 INFO - 'LOGNAME': 'cltbld', 23:17:38 INFO - 'MAIL': '/var/mail/cltbld', 23:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:38 INFO - 'MOZ_NO_REMOTE': '1', 23:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:38 INFO - 'NO_EM_RESTART': '1', 23:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:38 INFO - 'PWD': '/builds/slave/test', 23:17:38 INFO - 'SHELL': '/bin/bash', 23:17:38 INFO - 'SHLVL': '1', 23:17:38 INFO - 'TERM': 'linux', 23:17:38 INFO - 'TMOUT': '86400', 23:17:38 INFO - 'USER': 'cltbld', 23:17:38 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:38 INFO - '_': '/tools/buildbot/bin/python'} 23:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:17:38 INFO - Cleaning up... 23:17:38 INFO - Return code: 0 23:17:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:17:38 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')]} 23:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:38 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')]} 23:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:38 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 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:17:38 INFO - Using env: {'DISPLAY': ':0', 23:17:38 INFO - 'HOME': '/home/cltbld', 23:17:38 INFO - 'LANG': 'en_US.UTF-8', 23:17:38 INFO - 'LANGUAGE': 'en_US:en', 23:17:38 INFO - 'LOGNAME': 'cltbld', 23:17:38 INFO - 'MAIL': '/var/mail/cltbld', 23:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:38 INFO - 'MOZ_NO_REMOTE': '1', 23:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:38 INFO - 'NO_EM_RESTART': '1', 23:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:38 INFO - 'PWD': '/builds/slave/test', 23:17:38 INFO - 'SHELL': '/bin/bash', 23:17:38 INFO - 'SHLVL': '1', 23:17:38 INFO - 'TERM': 'linux', 23:17:38 INFO - 'TMOUT': '86400', 23:17:38 INFO - 'USER': 'cltbld', 23:17:38 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:38 INFO - '_': '/tools/buildbot/bin/python'} 23:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:38 INFO - Downloading/unpacking psutil>=3.1.1 23:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:17:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:17:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:17:40 INFO - Installing collected packages: psutil 23:17:40 INFO - Running setup.py install for psutil 23:17:40 INFO - building 'psutil._psutil_linux' extension 23:17:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:17:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:17:41 INFO - building 'psutil._psutil_posix' extension 23:17:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:17:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:17:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:17:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:17:41 INFO - Successfully installed psutil 23:17:41 INFO - Cleaning up... 23:17:41 INFO - Return code: 0 23:17:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:17:41 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')]} 23:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:41 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')]} 23:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:41 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 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:17:41 INFO - Using env: {'DISPLAY': ':0', 23:17:41 INFO - 'HOME': '/home/cltbld', 23:17:41 INFO - 'LANG': 'en_US.UTF-8', 23:17:41 INFO - 'LANGUAGE': 'en_US:en', 23:17:41 INFO - 'LOGNAME': 'cltbld', 23:17:41 INFO - 'MAIL': '/var/mail/cltbld', 23:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:41 INFO - 'MOZ_NO_REMOTE': '1', 23:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:41 INFO - 'NO_EM_RESTART': '1', 23:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:41 INFO - 'PWD': '/builds/slave/test', 23:17:41 INFO - 'SHELL': '/bin/bash', 23:17:41 INFO - 'SHLVL': '1', 23:17:41 INFO - 'TERM': 'linux', 23:17:41 INFO - 'TMOUT': '86400', 23:17:41 INFO - 'USER': 'cltbld', 23:17:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:41 INFO - '_': '/tools/buildbot/bin/python'} 23:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:17:43 INFO - Installing collected packages: mozsystemmonitor 23:17:43 INFO - Running setup.py install for mozsystemmonitor 23:17:43 INFO - Successfully installed mozsystemmonitor 23:17:43 INFO - Cleaning up... 23:17:43 INFO - Return code: 0 23:17:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:43 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 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:17:43 INFO - Using env: {'DISPLAY': ':0', 23:17:43 INFO - 'HOME': '/home/cltbld', 23:17:43 INFO - 'LANG': 'en_US.UTF-8', 23:17:43 INFO - 'LANGUAGE': 'en_US:en', 23:17:43 INFO - 'LOGNAME': 'cltbld', 23:17:43 INFO - 'MAIL': '/var/mail/cltbld', 23:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:43 INFO - 'MOZ_NO_REMOTE': '1', 23:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:43 INFO - 'NO_EM_RESTART': '1', 23:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:43 INFO - 'PWD': '/builds/slave/test', 23:17:43 INFO - 'SHELL': '/bin/bash', 23:17:43 INFO - 'SHLVL': '1', 23:17:43 INFO - 'TERM': 'linux', 23:17:43 INFO - 'TMOUT': '86400', 23:17:43 INFO - 'USER': 'cltbld', 23:17:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:43 INFO - '_': '/tools/buildbot/bin/python'} 23:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:43 INFO - Downloading/unpacking blobuploader==1.2.4 23:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:45 INFO - Downloading blobuploader-1.2.4.tar.gz 23:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:17:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:17:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:46 INFO - Downloading docopt-0.6.1.tar.gz 23:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:17:46 INFO - Installing collected packages: blobuploader, requests, docopt 23:17:46 INFO - Running setup.py install for blobuploader 23:17:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:17:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:17:46 INFO - Running setup.py install for requests 23:17:46 INFO - Running setup.py install for docopt 23:17:47 INFO - Successfully installed blobuploader requests docopt 23:17:47 INFO - Cleaning up... 23:17:47 INFO - Return code: 0 23:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:47 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')]} 23:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:47 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')]} 23:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:47 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 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:17:47 INFO - Using env: {'DISPLAY': ':0', 23:17:47 INFO - 'HOME': '/home/cltbld', 23:17:47 INFO - 'LANG': 'en_US.UTF-8', 23:17:47 INFO - 'LANGUAGE': 'en_US:en', 23:17:47 INFO - 'LOGNAME': 'cltbld', 23:17:47 INFO - 'MAIL': '/var/mail/cltbld', 23:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:47 INFO - 'MOZ_NO_REMOTE': '1', 23:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:47 INFO - 'NO_EM_RESTART': '1', 23:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:47 INFO - 'PWD': '/builds/slave/test', 23:17:47 INFO - 'SHELL': '/bin/bash', 23:17:47 INFO - 'SHLVL': '1', 23:17:47 INFO - 'TERM': 'linux', 23:17:47 INFO - 'TMOUT': '86400', 23:17:47 INFO - 'USER': 'cltbld', 23:17:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:47 INFO - '_': '/tools/buildbot/bin/python'} 23:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:17:47 INFO - Running setup.py (path:/tmp/pip-i7W6o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:17:47 INFO - Running setup.py (path:/tmp/pip-TrK5nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:47 INFO - Running setup.py (path:/tmp/pip-crcqua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:47 INFO - Running setup.py (path:/tmp/pip-dccYoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:47 INFO - Running setup.py (path:/tmp/pip-71YQxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:47 INFO - Running setup.py (path:/tmp/pip-P4UmPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:47 INFO - Running setup.py (path:/tmp/pip-sI3VNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:47 INFO - Running setup.py (path:/tmp/pip-BB5brP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:47 INFO - Running setup.py (path:/tmp/pip-v4woef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:47 INFO - Running setup.py (path:/tmp/pip-OPJnM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:48 INFO - Running setup.py (path:/tmp/pip-sVSN2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:48 INFO - Running setup.py (path:/tmp/pip-93lu9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:48 INFO - Running setup.py (path:/tmp/pip-GajlE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:48 INFO - Running setup.py (path:/tmp/pip-ySKjM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:48 INFO - Running setup.py (path:/tmp/pip-2YMmRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:48 INFO - Running setup.py (path:/tmp/pip-dzn7kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:48 INFO - Running setup.py (path:/tmp/pip-pXI7FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:17:48 INFO - Running setup.py install for manifestparser 23:17:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:17:48 INFO - Running setup.py install for mozcrash 23:17:48 INFO - Running setup.py install for mozdebug 23:17:48 INFO - Running setup.py install for mozdevice 23:17:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:17:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:17:48 INFO - Running setup.py install for mozfile 23:17:49 INFO - Running setup.py install for mozhttpd 23:17:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Running setup.py install for mozinfo 23:17:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Running setup.py install for mozInstall 23:17:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Running setup.py install for mozleak 23:17:49 INFO - Running setup.py install for mozlog 23:17:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Running setup.py install for moznetwork 23:17:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Running setup.py install for mozprocess 23:17:49 INFO - Running setup.py install for mozprofile 23:17:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:17:49 INFO - Running setup.py install for mozrunner 23:17:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:17:50 INFO - Running setup.py install for mozscreenshot 23:17:50 INFO - Running setup.py install for moztest 23:17:50 INFO - Running setup.py install for mozversion 23:17:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:17:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:17:50 INFO - Cleaning up... 23:17:50 INFO - Return code: 0 23:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:50 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')]} 23:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:50 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')]} 23:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:50 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 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:17:50 INFO - Using env: {'DISPLAY': ':0', 23:17:50 INFO - 'HOME': '/home/cltbld', 23:17:50 INFO - 'LANG': 'en_US.UTF-8', 23:17:50 INFO - 'LANGUAGE': 'en_US:en', 23:17:50 INFO - 'LOGNAME': 'cltbld', 23:17:50 INFO - 'MAIL': '/var/mail/cltbld', 23:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:50 INFO - 'MOZ_NO_REMOTE': '1', 23:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:50 INFO - 'NO_EM_RESTART': '1', 23:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:50 INFO - 'PWD': '/builds/slave/test', 23:17:50 INFO - 'SHELL': '/bin/bash', 23:17:50 INFO - 'SHLVL': '1', 23:17:50 INFO - 'TERM': 'linux', 23:17:50 INFO - 'TMOUT': '86400', 23:17:50 INFO - 'USER': 'cltbld', 23:17:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:50 INFO - '_': '/tools/buildbot/bin/python'} 23:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:17:50 INFO - Running setup.py (path:/tmp/pip-ISjwL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:17:50 INFO - Running setup.py (path:/tmp/pip-_7H3Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:50 INFO - Running setup.py (path:/tmp/pip-VXZmgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:50 INFO - Running setup.py (path:/tmp/pip-CN22MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:50 INFO - Running setup.py (path:/tmp/pip-l7ECwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:50 INFO - Running setup.py (path:/tmp/pip-dalwY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:50 INFO - Running setup.py (path:/tmp/pip-a2apXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:51 INFO - Running setup.py (path:/tmp/pip-c286wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:51 INFO - Running setup.py (path:/tmp/pip-0GpISl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:51 INFO - Running setup.py (path:/tmp/pip-cZI2XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:51 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)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:51 INFO - Running setup.py (path:/tmp/pip-GV6tmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:51 INFO - Running setup.py (path:/tmp/pip-lauMY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:51 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)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:51 INFO - Running setup.py (path:/tmp/pip-wfMwL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:51 INFO - Running setup.py (path:/tmp/pip-U5W0I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:51 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)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:51 INFO - Running setup.py (path:/tmp/pip-5Yvlqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:51 INFO - Running setup.py (path:/tmp/pip-8aSFGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:51 INFO - Running setup.py (path:/tmp/pip-331kXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:17:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:53 INFO - Downloading blessings-1.6.tar.gz 23:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:17:53 INFO - Installing collected packages: blessings 23:17:53 INFO - Running setup.py install for blessings 23:17:53 INFO - Successfully installed blessings 23:17:53 INFO - Cleaning up... 23:17:53 INFO - Return code: 0 23:17:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:17:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:54 INFO - Reading from file tmpfile_stdout 23:17:54 INFO - Current package versions: 23:17:54 INFO - argparse == 1.2.1 23:17:54 INFO - blessings == 1.6 23:17:54 INFO - blobuploader == 1.2.4 23:17:54 INFO - docopt == 0.6.1 23:17:54 INFO - manifestparser == 1.1 23:17:54 INFO - mozInstall == 1.12 23:17:54 INFO - mozcrash == 0.17 23:17:54 INFO - mozdebug == 0.1 23:17:54 INFO - mozdevice == 0.48 23:17:54 INFO - mozfile == 1.2 23:17:54 INFO - mozhttpd == 0.7 23:17:54 INFO - mozinfo == 0.9 23:17:54 INFO - mozleak == 0.1 23:17:54 INFO - mozlog == 3.2 23:17:54 INFO - moznetwork == 0.27 23:17:54 INFO - mozprocess == 0.22 23:17:54 INFO - mozprofile == 0.28 23:17:54 INFO - mozrunner == 6.11 23:17:54 INFO - mozscreenshot == 0.1 23:17:54 INFO - mozsystemmonitor == 0.3 23:17:54 INFO - moztest == 0.7 23:17:54 INFO - mozversion == 1.4 23:17:54 INFO - psutil == 3.1.1 23:17:54 INFO - requests == 1.2.3 23:17:54 INFO - wsgiref == 0.1.2 23:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:54 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 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:17:54 INFO - Using env: {'DISPLAY': ':0', 23:17:54 INFO - 'HOME': '/home/cltbld', 23:17:54 INFO - 'LANG': 'en_US.UTF-8', 23:17:54 INFO - 'LANGUAGE': 'en_US:en', 23:17:54 INFO - 'LOGNAME': 'cltbld', 23:17:54 INFO - 'MAIL': '/var/mail/cltbld', 23:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:54 INFO - 'MOZ_NO_REMOTE': '1', 23:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:54 INFO - 'NO_EM_RESTART': '1', 23:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:54 INFO - 'PWD': '/builds/slave/test', 23:17:54 INFO - 'SHELL': '/bin/bash', 23:17:54 INFO - 'SHLVL': '1', 23:17:54 INFO - 'TERM': 'linux', 23:17:54 INFO - 'TMOUT': '86400', 23:17:54 INFO - 'USER': 'cltbld', 23:17:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:54 INFO - '_': '/tools/buildbot/bin/python'} 23:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:17:54 INFO - Cleaning up... 23:17:54 INFO - Return code: 0 23:17:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:17:54 INFO - Using env: {'DISPLAY': ':0', 23:17:54 INFO - 'HOME': '/home/cltbld', 23:17:54 INFO - 'LANG': 'en_US.UTF-8', 23:17:54 INFO - 'LANGUAGE': 'en_US:en', 23:17:54 INFO - 'LOGNAME': 'cltbld', 23:17:54 INFO - 'MAIL': '/var/mail/cltbld', 23:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:54 INFO - 'MOZ_NO_REMOTE': '1', 23:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:54 INFO - 'NO_EM_RESTART': '1', 23:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:54 INFO - 'PWD': '/builds/slave/test', 23:17:54 INFO - 'SHELL': '/bin/bash', 23:17:54 INFO - 'SHLVL': '1', 23:17:54 INFO - 'TERM': 'linux', 23:17:54 INFO - 'TMOUT': '86400', 23:17:54 INFO - 'USER': 'cltbld', 23:17:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:54 INFO - '_': '/tools/buildbot/bin/python'} 23:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:54 INFO - Downloading/unpacking jsonschema 23:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:17:56 INFO - Downloading/unpacking functools32 (from jsonschema) 23:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:56 INFO - Downloading functools32-3.2.3-2.tar.gz 23:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:17:56 INFO - warning: no files found matching '*.txt' 23:17:56 INFO - no previously-included directories found matching 'build' 23:17:56 INFO - no previously-included directories found matching 'dist' 23:17:56 INFO - no previously-included directories found matching '.git*' 23:17:56 INFO - Installing collected packages: jsonschema, functools32 23:17:56 INFO - Running setup.py install for functools32 23:17:56 INFO - warning: no files found matching '*.txt' 23:17:56 INFO - no previously-included directories found matching 'build' 23:17:56 INFO - no previously-included directories found matching 'dist' 23:17:56 INFO - no previously-included directories found matching '.git*' 23:17:56 INFO - Successfully installed jsonschema functools32 23:17:56 INFO - Cleaning up... 23:17:56 INFO - Return code: 0 23:17:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:56 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 0x7f9d3d04df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:56 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 23:17:56 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 23:17:56 INFO - Using env: {'DISPLAY': ':0', 23:17:56 INFO - 'HOME': '/home/cltbld', 23:17:56 INFO - 'LANG': 'en_US.UTF-8', 23:17:56 INFO - 'LANGUAGE': 'en_US:en', 23:17:56 INFO - 'LOGNAME': 'cltbld', 23:17:56 INFO - 'MAIL': '/var/mail/cltbld', 23:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:56 INFO - 'MOZ_NO_REMOTE': '1', 23:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:56 INFO - 'NO_EM_RESTART': '1', 23:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:56 INFO - 'PWD': '/builds/slave/test', 23:17:56 INFO - 'SHELL': '/bin/bash', 23:17:56 INFO - 'SHLVL': '1', 23:17:56 INFO - 'TERM': 'linux', 23:17:56 INFO - 'TMOUT': '86400', 23:17:56 INFO - 'USER': 'cltbld', 23:17:56 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:56 INFO - '_': '/tools/buildbot/bin/python'} 23:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:57 INFO - Downloading/unpacking flake8 23:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:17:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:17:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:17:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:17:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:17:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:17:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:17:59 INFO - no previously-included directories found matching 'docs/_build' 23:17:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:17:59 INFO - Running setup.py install for pep8 23:17:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:17:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:17:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:17:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:17:59 INFO - no previously-included directories found matching 'docs/_build' 23:17:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:17:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:17:59 INFO - Cleaning up... 23:18:00 INFO - Return code: 0 23:18:00 INFO - Running post-action listener: _resource_record_post_action 23:18:00 INFO - Running post-action listener: _start_resource_monitoring 23:18:00 INFO - Starting resource monitoring. 23:18:00 INFO - ##### 23:18:00 INFO - ##### Finished create-virtualenv step (success) 23:18:00 INFO - ##### 23:18:00 INFO - ##### 23:18:00 INFO - ##### Running install step. 23:18:00 INFO - ##### 23:18:00 INFO - Running pre-action listener: _resource_record_pre_action 23:18:00 INFO - Running main action method: install 23:18:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:18:00 INFO - Reading from file tmpfile_stdout 23:18:00 INFO - Detecting whether we're running mozinstall >=1.0... 23:18:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:18:00 INFO - Reading from file tmpfile_stdout 23:18:00 INFO - Output received: 23:18:00 INFO - Usage: mozinstall [options] installer 23:18:00 INFO - Options: 23:18:00 INFO - -h, --help show this help message and exit 23:18:00 INFO - -d DEST, --destination=DEST 23:18:00 INFO - Directory to install application into. [default: 23:18:00 INFO - "/builds/slave/test"] 23:18:00 INFO - --app=APP Application being installed. [default: firefox] 23:18:00 INFO - mkdir: /builds/slave/test/build/application 23:18:00 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'] 23:18:00 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 23:18:17 INFO - Reading from file tmpfile_stdout 23:18:17 INFO - Output received: 23:18:17 INFO - /builds/slave/test/build/application/firefox/firefox 23:18:17 INFO - Running post-action listener: _resource_record_post_action 23:18:17 INFO - ##### 23:18:17 INFO - ##### Finished install step (success) 23:18:17 INFO - ##### 23:18:17 INFO - ##### 23:18:17 INFO - ##### Running run-tests step. 23:18:17 INFO - ##### 23:18:17 INFO - Running pre-action listener: _resource_record_pre_action 23:18:17 INFO - Running main action method: run_tests 23:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:18:17 INFO - Python 2.7.3 23:18:17 INFO - Return code: 0 23:18:17 INFO - grabbing minidump binary from tooltool 23:18: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')]} 23:18:17 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 0x14649c0>, '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 0x14658c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1465d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:18:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:18:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:18:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:18:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:18:17 INFO - Return code: 0 23:18:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:18:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:18:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:18:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:18:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:18:18 INFO - Return code: 0 23:18:18 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/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:18:18 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/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:18:18 INFO - Using env: {'DISPLAY': ':0', 23:18:18 INFO - 'HOME': '/home/cltbld', 23:18:18 INFO - 'LANG': 'en_US.UTF-8', 23:18:18 INFO - 'LANGUAGE': 'en_US:en', 23:18:18 INFO - 'LOGNAME': 'cltbld', 23:18:18 INFO - 'MAIL': '/var/mail/cltbld', 23:18:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:18:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:18 INFO - 'MOZ_NO_REMOTE': '1', 23:18:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:18 INFO - 'NO_EM_RESTART': '1', 23:18:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:18 INFO - 'PWD': '/builds/slave/test', 23:18:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:18:18 INFO - 'SHELL': '/bin/bash', 23:18:18 INFO - 'SHLVL': '1', 23:18:18 INFO - 'TERM': 'linux', 23:18:18 INFO - 'TMOUT': '86400', 23:18:18 INFO - 'USER': 'cltbld', 23:18:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404', 23:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:18 INFO - '_': '/tools/buildbot/bin/python'} 23:18:18 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/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:18:18 INFO - mozversion application_buildid: 20160602203047 23:18:18 INFO - mozversion application_changeset: 0c48702e8ff4cf427e443ed91630465c39f6c4ee 23:18:18 INFO - mozversion application_display_name: Nightly 23:18:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:18:18 INFO - mozversion application_name: Firefox 23:18:18 INFO - mozversion application_remotingname: firefox 23:18:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:18:18 INFO - mozversion application_vendor: Mozilla 23:18:18 INFO - mozversion application_version: 49.0a1 23:18:18 INFO - mozversion platform_buildid: 20160602203047 23:18:18 INFO - mozversion platform_changeset: 0c48702e8ff4cf427e443ed91630465c39f6c4ee 23:18:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:18:18 INFO - mozversion platform_version: 49.0a1 23:18:18 INFO - using testdate: 1464934698 23:18:18 INFO - actual date: 1464934698 23:18:18 INFO - starting webserver on 'localhost:44140' 23:18:18 INFO - SUITE-START | Running 2 tests 23:18:18 INFO - TEST-START | dromaeo_css 23:18:18 INFO - operating with platform_type : linux_ 23:18:18 INFO - Initialising browser for dromaeo_css test... 23:18:18 INFO - TEST-INFO | started process 26633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprmAVHp/profile http://localhost:44140/getInfo.html) 23:18:22 INFO - PROCESS | 26633 | __metrics Screen width/height:1600/1200 23:18:22 INFO - PROCESS | 26633 | colorDepth:24 23:18:22 INFO - PROCESS | 26633 | Browser inner width/height: 1024/697 23:18:22 INFO - PROCESS | 26633 | __metrics 23:18:22 ERROR - PROCESS | 26633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:18:23 INFO - TEST-INFO | 26633: exit 0 23:18:23 INFO - Browser initialized. 23:18:23 INFO - Running cycle 1/1 for dromaeo_css test... 23:18:23 INFO - TEST-INFO | started process 26752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprmAVHp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:35 INFO - PROCESS | 26752 | RSS: Main: 167669760 23:18:35 INFO - PROCESS | 26752 | 23:19:25 INFO - PROCESS | 26752 | 1464934765298 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:21:32 INFO - PROCESS | 26752 | Cycle 1(1): loaded http://localhost:44140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44140/tests/dromaeo/cssquery-ext.html) 23:21:33 INFO - PROCESS | 26752 | RSS: Main: 171601920 23:21:33 INFO - PROCESS | 26752 | 23:24:36 INFO - PROCESS | 26752 | Cycle 1(1): loaded http://localhost:44140/tests/dromaeo/cssquery-ext.html (next: http://localhost:44140/tests/dromaeo/cssquery-jquery.html) 23:24:36 INFO - PROCESS | 26752 | RSS: Main: 170188800 23:24:36 INFO - PROCESS | 26752 | 23:27:38 INFO - PROCESS | 26752 | Cycle 1(1): loaded http://localhost:44140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44140/tests/dromaeo/cssquery-mootools.html) 23:27:39 INFO - PROCESS | 26752 | RSS: Main: 171872256 23:27:39 INFO - PROCESS | 26752 | 23:30:41 INFO - PROCESS | 26752 | Cycle 1(1): loaded http://localhost:44140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44140/tests/dromaeo/cssquery-prototype.html) 23:30:41 INFO - PROCESS | 26752 | RSS: Main: 169213952 23:30:41 INFO - PROCESS | 26752 | 23:33:44 INFO - PROCESS | 26752 | Cycle 1(1): loaded http://localhost:44140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44140/tests/dromaeo/cssquery-yui.html) 23:33:44 INFO - PROCESS | 26752 | RSS: Main: 171347968 23:33:44 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | Cycle 1(1): loaded http://localhost:44140/tests/dromaeo/cssquery-yui.html (next: http://localhost:44140/tests/dromaeo/cssquery-dojo.html) 23:36:47 INFO - PROCESS | 26752 | RSS: Main: 172392448 23:36:47 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | __start_tp_report 23:36:47 INFO - PROCESS | 26752 | _x_x_mozilla_page_load 23:36:47 INFO - PROCESS | 26752 | _x_x_mozilla_page_load_details 23:36:47 INFO - PROCESS | 26752 | |i|pagename|runs| 23:36:47 INFO - PROCESS | 26752 | |0;dojo.html;3122.1726242545724;3165;3187.6015498062748;3202.343519578487;3213.582234309541;5461.918071228934;5465.890682186359;5479.726013699314;5576.5817563682685;5596.748146333425;5383.138697808351;5471.863203419916;5522.447755224475;5539.473749993755;5650.124230744231;4977.377827771537;5004.12427825131;5093.949060509403;5143.408508021569;5175.922361164586;828.1757649878317;4938.506149385069;5002.24966255061;5018.498150184989;5068.189089745623;4986.351774269358;5015.247712843066;5026.773795179226;5042.117629414856;5064.2403639454005;5045;5047.974760126176;5059.06407314648;5076.873078173038;5105.974470127626;4991.700497970133;5020.4226513951;5029.748512574393;5055.87360315995;5066.214736715815;5479.287692599976;5497.890042199134;5508.9724551376985;5509.669419834822;5556.027695153332;5749.281339832521;5938.198343223653;5944.881102377972;5957.136215248808;5968.492678122365;5984.251968503937;6034.155218269446;6047.274327080779;6058.4244496772735;6113.480354169901;5584.497395234448;5599.860003499904;5600.719964001824;5606.635568688022;5621.634593751393;5902.232709747791;6027.065804800263;6078.9361861674915;6184.041473571604;6196.3803619638575;5850.707464626752;5852.619579727304;5856.531477481792;5872.324682661463;5874.295084589877;5992.43071908168;5998.610090344114;5999.730012149376;6009.06859436788;6023.367546407564;5906.852328691731;5919.816036792658;5921.555883308769;5956.880862382728;5976.551758618121;5923.052311630118;5987.820365388958;5993.160957465958;5998.400159983967;6007.339192688801;4381.430414046217;4509.436320459942;4509.864704058818;4532.7280363178315;4573.222552166139;3922.3528117860806;3948.269570129535;3993.1414745829206;4019.5980401960155;4023.295923213426;5598.300212473441;5667.574931880043;5686.943130568724;5692.57305702074;5722.942770572325;5836.503897168704;6010;6030.095485677096;6042.425969532887;6043.7280322385595;5662.292213473316;5708.80019199326;5727.0550359190265;5731.739017416162;5755.3381361144;5128.076946149654;5157.381114266312;5161.535461808456;5166.844994650167;5179.974100129475;5931.495822855106;6106.582013105394;6169.2288463942;6220.875582488325;6264.436200741955;6015.699215039318;6023.186869772525;6049.455549000611;6050.969745151246;6105.786297479567;6189.141925996568;6200.286966998672;6244.250689917239;6244.843878903063;6250.124982502544;5690.544756419394;5875.353711091862;5917.230760001173;5941.9405805943115;5989.880202396015;6024.548158888013;6038.607490513103;6041.516678665784;6051.062085376773;6085;5803.622764520293;5813.447722466359;5847.970760146172;5865.061590145556;5886.557793340659;5555.666660000413;5786.045302525036;5826.067829147486;5867.266591676041;5898.439648233411;5719.57103217252;5774.39368866263;5795.971020144872;5809.30288365382;5825.854353641193;5816.040353341651;5830.883382332245;5863.648181108976;5930.288365396007;5944.762209511571;5544.528715059104;5624.718764061862;5671.858203544944;5674.120511320752;5748.022836117786 23:36:47 INFO - PROCESS | 26752 | |1;ext.html;568.5394830187548;602.7769725201676;609.987800243995;639.7121295417062;663.860589276252;39633.405498917506;40373.79813100934;43896;44312.77843610785;44430.55569444304;44520.554794452044;44683.329750053774;44875.10249795002;44990.77504612481;45314.54685453144;8582.699605513793;8681.348898832613;8726.38915275931;8784.297256219486;8789;8853.070427605073;9014.188723014928;9020.729378118667;9026.774330641754;9026.909730902706;8901.376903616749;8958.731238062868;9004.8649270261;9042.86435703465;9102.954485227598;8750.993635731877;8812.779680508007;8876.112388761137;8878.822423551557;8928.687495937611;8862.468251904906;8959.37284390093;9027.14242146995;9029.593668284877;9046.502442365667;41613;42182.78908605468;42414.57585424137;42461;42491;2974.181278688858;3464.9653503464897;3474.4961980512685;3538.8761393351365;3625.2024554597947;31377.8431107843;31468.842655786575;31484.842575787203;31628.841855790575;31718;3668.816559172031;3711.814409279525;3712.888613341604;3731.9626803731885;3926.705497087701;308352;308471;308740;311674;311953.4402327997;30938.381232375228;31634.209144771103;31859.52210716841;34704;35123.297534049176;36572;36803.079923001605;36828.631713682524;36910.8154459226;36993.445098323544;15170.31733571992;15178.848211517965;15266.770998435033;15324.846751532565;15415.997960132556;12873.485060597472;12953.870461295266;12973.740525189443;12976.740465190644;13089.738205235843;8221.218984196492;8259.091499935003;8286;8307.376946728898;8348.248657620721;3231.9030429087165;3276.770626056201;3305.190228394011;3309.321589074234;3312.668733126668;1089.4062735809002;1125.6004118537965;1133.3369978562632;1162.947667354954;1169.216624861345;32713.34573308568;32820.507692384635;32968.34063318768;33058.17354566155;33110.17224569405;1140.406988366045;1158.1603337580186;1180.5749930025183;1210.425048102162;1302.5310888080282;17083.060431676127;17456.301747930196;17544.736828947574;17572.38496652611;17636.647267054588;535645;537048;538362;538628;541076;59199;59899.70050149722;60234.698826506465;60333.39666603366;60413.69793151006;1349.6828245362333;1385.9584212473642;1396.9662449787083;1424.1526291856328;1424.5939907126626;31334.74661013534;32481;32637;32885.47664747346;32890;52004;52174.47825521696;52260;52602.47397525976;52616;433224;433440;434454;436038;436521;28047.579286310312;28185.295367615974;28537.14388568346;28696.713032869404;28794.712052879204;50004;50327.74836125796;50444;50887;51790.482095178566;42582;43064;43358.56641433672;43682.34476482792;43793.78103109464;41298;41362.172756545304;41935.580644194386;42140.157196855274;42433.44498201216;32426.35147297088;41201.1759764809;41402;41427.171456571305;41909;33461.33077338391;38082.809585951894;38203.23593528169;38535.80732096434;38543.614563855124;29027.709722902502;29109.854450728457;29188.56217156702;29200.561991569717;29587.260318492208 23:36:47 INFO - PROCESS | 26752 | |2;jquery.html;383.5799799219855;395.15831279374925;398.3705744923022;399.8920291521289;406.94099355593437;13674.863251367484;18106.18522166504;18776.71834922477;19591.510212244702;19654.803451965476;18514.53713657159;18515.259389624433;18753.812461875375;19714.50713732154;19876.602467950634;5570.944290557103;5673.574481913853;5674.978503869302;5790.855228619297;5809.3900140485275;5618.353889302742;5663.037283661787;5730.856728581798;5737.196792449061;5740.167675687044;5233.110371236899;5570.192322113291;5574.581906357019;5705.286839145107;5749.511291540224;5560.582956278255;5612.41069687681;5616.691081990489;5675;6298.811035668938;5593.552515798727;5595.328560572757;5627.521660658849;5630.296212973379;5656.4060773618585;13064;13244.668883277898;13687;13721.588352349345;13775;2144.7560414959285;2172.7935846094597;2218.900149493277;2372.750861159588;2411.7097352916107;9643.758906027335;9707.757306067335;10317.638882639072;10464.42445665488;10595.205359597983;1908.1031914999928;1966.8229859312587;2010.859239853211;2036.9694454583193;2045.3148195354424;78571;82653;82803.17196828075;83602.98382097033;84081.57959210227;10567;10676.839847402296;10730.356178629307;10847.620333288298;10962.56149754001;15142.924285378502;15187.772183417257;15189.696206075816;15222.847771522365;15258;7850.411219158586;8052.919470805217;8074.74841399584;8105.716299929592;8247.463914845515;7749;7769.261920117579;7785.532868027936;7865.134835168127;7882.408819338572;4575.24508456101;4659.673822832437;4676.3453116563705;4678.883027924261;4700.976495117503;1948.503131701407;1956.1392987085637;1990.4526255279914;1991.3030439346112;2005.1377907499623;933.4399360383851;967.7580604848788;1051.7896420715888;1061.9009325348227;1063.3991794636006;18331.541711457052;18954.81045189558;19698.60602787965;19716;19772.505687357643;991.3952488981715;1003.7590978165334;1020.7295066807302;1036.6475398364591;1069.5828626835541;10476.52855621499;11075.280106793032;11086.279391839505;11142.27575207609;11173.72065698364;505521;509091;510891;520081;521636;90974.54512727527;91805.62291565632;92837;93553.53223233977;94792;970.8543718442149;984.07988530724;995.7354160216485;998.9350692204983;1007.4559737741538;16827.326906923587;17160;17261.309547618457;17343.2195551198;17581.120943952494;40256.396154057125;41026.1794764109;41144;41274;41579.16841663211;55388;55923.440765591826;56344;56458.43541564532;56679;6470.029495575702;8097.2307630774985;8406.243438090602;8594.570271486526;8759.255463285437;12895.806562901376;12939.805902911652;13001.674958126123;13018.15382000167;13129.737405252032;11299.943500282774;11333.773324533298;11571.884281157081;11603.781602931907;11606.361650109326;11125.221234513507;11152.44237788091;11213.943930280622;11308.208425410472;11321.320720756781;11680.47437865281;11701.531938722695;11729.706757331134;11814.881851181723;11866.40667966581;8367.205115514016;8367.414281000514;8445.831083378422;8451.070382257823;8678.78303042429;8415.990081190052;10489.370637761758;11547.076233901436;11672.941635291769;11715.062794976551 23:36:47 INFO - PROCESS | 26752 | |3;mootools.html;1471.4187895781167;1526.503886236973;1643.9835601643988;1725.818789027153;1733.4279687703051;7815.921840781591;8585.399022068457;8674.175953284435;9245.537723113852;9268.443893366395;8621.913780862189;8771.47371157731;8936.508492032935;8961;8997.955010224956;2324.4421338878674;2363.657269695893;2379.8572085674828;2381.523695260946;2389.283215035491;2257.582347265761;2287.0737351372723;2292.106078629336;2305.0779688124717;2321.767823217682;2301.9424514387106;2302.470431800687;2302.8848557572137;2337.041812856729;2357.316378250314;2258.5369999150134;2284.794368506834;2290.0725206291477;2294.6672732453785;2306.0660432524855;2275.9317220483413;2295.908163673451;2298.747137814839;2305.0664480885266;2307.515421761432;8756.60595273208;8767.561621918878;8814.823703525957;8827.69103081389;8858.955705221497;5110.233464980245;5226.581873450153;5269.710165940872;5273.894522109575;5287.814926477555;3221.774475786696;3389.1527118220447;3406.386850366933;3515.455104458813;3537.0980399998093;1122.9057807189615;1145.9601908602617;1157.7742340243656;1169.7251145980688;1176.394157009141;12622.305773182472;12707.745845083138;12729.236245825281;12812;12846.550370736979;4582.564656357641;4618.49196588375;4720.197566413718;4760.571548560646;4767.332573439721;10815.621453249098;10821.783564328827;10844.349339039683;10850.45747712627;10885;5168.483151684802;5194.740262986836;5221.269022336875;5226.790928362899;5246.029484545371;4372.628326592276;4776.188048031843;4817.0365926814075;4926.975365123151;4928.866360736979;4112.280350938574;4139.834406623701;4167.604077612622;4202.810873510699;4258.936115958263;1280.4875013068643;1299.051692264652;1310.8361454818148;1321.4251800466827;1326.5158217250635;895.5925054100369;986.4525188520297;996;1043.1811028342715;1043.639944219243;6019.187409699634;6191;6236.906446403307;6247.437730604177;6254.843628909222;465.6507619285536;468.1760102220049;470.5509408542225;474.3335613463021;476.9785359658824;4320.265554855682;4364.781760911942;4376.978115109468;4391.538888416734;4400.339949007611;11151.888481115086;11483.138764592522;11537.596184133683;11564.363959982113;11572.189946703818;10608.734781630366;11027.83458248127;11062.39156846365;11399.943000284946;11410.885891140982;8350.373721970876;8441.95779021101;8505.53219572917;8571.314294856396;8593.398462107592;5857.121431785095;6122.846928826815;6132.969335153474;6208.2239720034995;6230.968845155745;10144.898551014396;10247.180225581786;10509.579616815241;10569.947150264506;10571.841422378517;10253.384796912209;10509.842352364567;10550.103241224275;10632.41521716313;10953.233273670767;7380.667869945758;7714.305712485679;7993.360531157377;8151.755447336589;8284.668613255402;8796.692115775917;8845.51349675774;8894.377393582387;8921.06328835463;8943.955280223558;7934.60326983637;7941.722039728582;8012.399070069651;8118.512889226666;8221.17788221173;7714.922850771421;7748.380129589506;7951.801204969922;8144.55204963709;8182.263596276363;7184.389326907062;7224.674889630084;7235.3488186063505;7235.421166306577;7246.818829529304;5030.295758593873;5038.445770965264;5109.386873575195;5124.487551244845;5185.559227465707;5255.369355677343;5258.158694608845;5284.260921603799;5333.173358129496;5400.162974738922 23:36:47 INFO - PROCESS | 26752 | |4;prototype.html;312.8826689991253;327.41066081054106;333.36826713378156;333.6663336663337;335.1019268360794;5426.457354264571;5437.6465529740635;5591.776328946842;5598.804041858536;5643.661380317179;5478.616496845212;5495.230667706514;5521.641093328931;5525.254090697755;5529.30883639545;4365.694401391896;4382.561743825624;4387.451568553931;4393.538678438766;4403.546829546242;4031.9395209071886;4280.97859510702;4296.785160741966;4367.951691594027;4401.889952751175;4222.9577704222875;4224.471941007374;4264;4296.892577685568;4313.331433627793;4303.698741088125;4308.095299987007;4317.913641727164;4319.632831209351;4327.740335579875;3550.804705741183;3781.8487260509546;3789.7347185697013;3790.450384694204;3793.3930571108767;5251.921221181686;5349.491798279158;5356.758945847408;5368.8389348319615;5387.353517577876;4842.346283251751;4860.295257187723;4870.561649451531;4873.829415970459;4912.256149067101;5560.165975103726;5810.970945145289;5842.4741773240185;5852.297724273115;5852.297724273115;4113.670906327487;4115.115250221217;4122.896927576835;4137.46212992309;4144.590839114716;6006.279246490405;6095.359987201325;6118.3269840317525;6145.108959200891;6177.320494745574;4094.651954583834;4172.415861779354;4184.4141820145205;4190.392393102983;4220.662347012231;4243.745375277494;4250.426192463978;4250.723702959298;4253.383259427365;4263.936040959388;4887.413510378707;4895.877603059952;4903.33804936329;4905.754712264444;4960.454350021495;5793.978571856034;5817.796377126865;5874.676892770854;5891.440313170242;5894.263217097863;1459.1682740837832;1460.7443697353133;1465.2966576043345;1468;1476.9704605908037;896.4576431259125;916.7983043730369;920.6869664314165;923.5243849417556;937.3906960475746;4814.350062741555;4814.8796280093275;4958.884251043559;5028.547430731179;5117.74411279442;5312.167302280707;5353.009693206769;5463.699496527729;5496.31296087989;5514.420985796514;4991.226359914219;5121.359830021247;5140.537351638296;5204.947950520522;5698.461415417814;3152.9684703152675;3200.1679563313705;3207.711305982473;3210.293735378213;3216.710496055366;6004.369541198112;6170.598911070766;6242.906356404657;6288.5598008139905;6310.968445157745;6047.762327938691;6150.446459818549;6159.907601385983;6166.81499555014;6170.969145154246;6155.4767844732805;6172.197614310201;6203.2556093269095;6233.0338797486465;6243.344448832807;5770.571568438505;5942.64344139353;5982.4316689914385;5985.341612422717;5992.161097446274;5936.198613187337;5951.910721339097;5960.433758792908;5963.254593175853;6008.24896887889;5957.582969192115;6206.348333424925;6208.037754148114;6239.688015599111;6248.593841400295;4184.476940382452;4185.476815398075;4188.392683061;4192.0925978679015;4211.978940105279;6032.276126864629;6091.42131497507;6094.7257373417415;6098.329183789869;6112.908306375319;5447.782088716407;5839.445252700986;5864.208331875142;5865.618734782396;5924.318703348998;5914.201582786441;5920.526357891445;5922.496587789914;5934.6142500737315;5951.779885123626;5581.665100094007;5795.275590551181;5803.883922321615;5803.941960580509;5872.0898260769645;5903.940960590511;5905.202797622438;5917.319508256605;5960.314563825215;5969.791057312973;5728.283964504437;5779.8555036124435;5788.942110578841;5838.416158384128;5844.736986835687 23:36:47 INFO - PROCESS | 26752 | |5;yui.html;800.5036877136173;829.6639860856352;842.2083241752756;845.5645342648534;859.1451505751778;15127.092374457527;16119.516414507569;16160.676786464264;16426;16491.58771030725;14375.784363234534;14606.780898286534;14661.926690366534;14676.119432834037;14697.559073227794;792.5442870349558;806.8749343851683;825.7976795685065;830.0744669693279;838.4047326398264;829.8838162657232;833.2292629317888;837.0624900111883;837.9706710265142;838.3628442383771;862.8533149364623;868.452874688945;870.8563087090622;871.6556960000796;875.8117004843957;864.2265172670487;869.5478351257342;870.6343335798948;870.9331069439917;871.2637821041274;632.968351582419;634.511426201822;635.9491240700733;637.0698779781525;637.2639601260552;15476.535703928901;15496.147711875843;15542.844571554253;15550.377984880592;15566.533004009898;14604.634884127876;14717.92641036788;14809.259537023107;14824.629384265372;15067.17130557819;12242.755144897052;12403.627891163189;12451;12579.496820127184;12936.223826570342;3762.3039737648623;3814.9618503814886;3855.0747820522874;3909.354956432185;3980.5024371953505;79505.60247198727;80147.19852801514;80664.58006259822;81361;81774.18225817726;11033.024627021308;11055.502502387411;11178.44107794607;11222.831657525143;11365.659030229106;21595;21823;21930.780692192875;21960.02359787627;22009.889950550143;8464.873026904601;8787.692430764893;8801;8802.163794439519;8832.55837208137;4944.596747212368;4945.876353091129;4989.55094041538;5043.394792624908;5205.29728486657;3556.928861422757;3681;3684.705223582107;3691.557013158438;3698.6301369863336;590.8345663214221;608.5983251054283;610.5970059760537;620.2990620598785;620.3083561828529;663.8871391863298;770.4067867741919;783.7021931666045;789.9684012639545;796.8645330293864;10057.59769609222;10085.747856303504;10127.544260508295;10178.389296642225;10230.846537301946;656.474820143883;715.6564848872571;753.7173559915032;760.1448370583093;769.5575044349522;4598.402207712976;4726.645501587394;4754.165378747827;4778.832740854054;4850.442199147073;68884;88558.55720721355;90740;91851;106414;104761.47619261855;106806;106955;108048.45975770228;109908;90722.54638726896;91074;91098;92326.03144202416;93909;9676.70969870905;9679.322447428613;9759.268054895769;9984.051515106054;10025.749356266151;51268.487315127866;51450;51664.741676292884;51860;53054.204186938;68099.31900681127;76191.23808761842;76270;78802.21197788179;80232;13471.663208419868;13495.865041349462;13589;13684.589462316146;14206.644833879236;15478.9226053869;15535.533933981998;15719.417490199712;16034.438794642132;16199.514014579581;13333.66665833362;13759.966470746916;13944.16335019902;13961.301934903011;13977.510787122403;13430.040724116654;13648.590542283748;13758.380872860545;13992.440302387791;14498.347574358968;13276.601701948957;13504.392302346221;13651.249181295125;13821.239831809347;13851.930740346637;11196.608118715805;11423.314601123959;11597.942010289895;11772.234804737665;11805.291682499077;10961.232713709964;11367.54529818831;11833.290002599872;12065.879341206475;12300.81548776787 23:36:47 INFO - PROCESS | 26752 | __end_tp_report 23:36:47 INFO - PROCESS | 26752 | __start_cc_report 23:36:47 INFO - PROCESS | 26752 | _x_x_mozilla_cycle_collect,360 23:36:47 INFO - PROCESS | 26752 | __end_cc_report 23:36:47 INFO - PROCESS | 26752 | __startTimestamp1464935807712__endTimestamp 23:36:47 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | ------- Summary: start ------- 23:36:47 INFO - PROCESS | 26752 | Number of tests: 6 23:36:47 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | [#0] dojo.html Cycles:165 Average:5510.08 Median:5755.34 stddev:748.08 (13.0%) stddev-sans-first:726.54 23:36:47 INFO - PROCESS | 26752 | Values: 3122.2 3165.0 3187.6 3202.3 3213.6 5461.9 5465.9 5479.7 5576.6 5596.7 5383.1 5471.9 5522.4 5539.5 5650.1 4977.4 5004.1 5093.9 5143.4 5175.9 828.2 4938.5 5002.2 5018.5 5068.2 4986.4 5015.2 5026.8 5042.1 5064.2 5045.0 5048.0 5059.1 5076.9 5106.0 4991.7 5020.4 5029.7 5055.9 5066.2 5479.3 5497.9 5509.0 5509.7 5556.0 5749.3 5938.2 5944.9 5957.1 5968.5 5984.3 6034.2 6047.3 6058.4 6113.5 5584.5 5599.9 5600.7 5606.6 5621.6 5902.2 6027.1 6078.9 6184.0 6196.4 5850.7 5852.6 5856.5 5872.3 5874.3 5992.4 5998.6 5999.7 6009.1 6023.4 5906.9 5919.8 5921.6 5956.9 5976.6 5923.1 5987.8 5993.2 5998.4 6007.3 4381.4 4509.4 4509.9 4532.7 4573.2 3922.4 3948.3 3993.1 4019.6 4023.3 5598.3 5667.6 5686.9 5692.6 5722.9 5836.5 6010.0 6030.1 6042.4 6043.7 5662.3 5708.8 5727.1 5731.7 5755.3 5128.1 5157.4 5161.5 5166.8 5180.0 5931.5 6106.6 6169.2 6220.9 6264.4 6015.7 6023.2 6049.5 6051.0 6105.8 6189.1 6200.3 6244.3 6244.8 6250.1 5690.5 5875.4 5917.2 5941.9 5989.9 6024.5 6038.6 6041.5 6051.1 6085.0 5803.6 5813.4 5848.0 5865.1 5886.6 5555.7 5786.0 5826.1 5867.3 5898.4 5719.6 5774.4 5796.0 5809.3 5825.9 5816.0 5830.9 5863.6 5930.3 5944.8 5544.5 5624.7 5671.9 5674.1 5748.0 23:36:47 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | [#1] ext.html Cycles:180 Average:57643.36 Median:21780.06 stddev:116342.22 (534.2%) stddev-sans-first:116589.67 23:36:47 INFO - PROCESS | 26752 | Values: 568.5 602.8 610.0 639.7 663.9 39633.4 40373.8 43896.0 44312.8 44430.6 44520.6 44683.3 44875.1 44990.8 45314.5 8582.7 8681.3 8726.4 8784.3 8789.0 8853.1 9014.2 9020.7 9026.8 9026.9 8901.4 8958.7 9004.9 9042.9 9103.0 8751.0 8812.8 8876.1 8878.8 8928.7 8862.5 8959.4 9027.1 9029.6 9046.5 41613.0 42182.8 42414.6 42461.0 42491.0 2974.2 3465.0 3474.5 3538.9 3625.2 31377.8 31468.8 31484.8 31628.8 31718.0 3668.8 3711.8 3712.9 3732.0 3926.7 308352.0 308471.0 308740.0 311674.0 311953.4 30938.4 31634.2 31859.5 34704.0 35123.3 36572.0 36803.1 36828.6 36910.8 36993.4 15170.3 15178.8 15266.8 15324.8 15416.0 12873.5 12953.9 12973.7 12976.7 13089.7 8221.2 8259.1 8286.0 8307.4 8348.2 3231.9 3276.8 3305.2 3309.3 3312.7 1089.4 1125.6 1133.3 1162.9 1169.2 32713.3 32820.5 32968.3 33058.2 33110.2 1140.4 1158.2 1180.6 1210.4 1302.5 17083.1 17456.3 17544.7 17572.4 17636.6 535645.0 537048.0 538362.0 538628.0 541076.0 59199.0 59899.7 60234.7 60333.4 60413.7 1349.7 1386.0 1397.0 1424.2 1424.6 31334.7 32481.0 32637.0 32885.5 32890.0 52004.0 52174.5 52260.0 52602.5 52616.0 433224.0 433440.0 434454.0 436038.0 436521.0 28047.6 28185.3 28537.1 28696.7 28794.7 50004.0 50327.7 50444.0 50887.0 51790.5 42582.0 43064.0 43358.6 43682.3 43793.8 41298.0 41362.2 41935.6 42140.2 42433.4 32426.4 41201.2 41402.0 41427.2 41909.0 33461.3 38082.8 38203.2 38535.8 38543.6 29027.7 29109.9 29188.6 29200.6 29587.3 23:36:47 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | [#2] jquery.html Cycles:180 Average:29256.95 Median:389.37 stddev:84619.60 (21732.5%) stddev-sans-first:84829.21 23:36:47 INFO - PROCESS | 26752 | Values: 383.6 395.2 398.4 399.9 406.9 13674.9 18106.2 18776.7 19591.5 19654.8 18514.5 18515.3 18753.8 19714.5 19876.6 5570.9 5673.6 5675.0 5790.9 5809.4 5618.4 5663.0 5730.9 5737.2 5740.2 5233.1 5570.2 5574.6 5705.3 5749.5 5560.6 5612.4 5616.7 5675.0 6298.8 5593.6 5595.3 5627.5 5630.3 5656.4 13064.0 13244.7 13687.0 13721.6 13775.0 2144.8 2172.8 2218.9 2372.8 2411.7 9643.8 9707.8 10317.6 10464.4 10595.2 1908.1 1966.8 2010.9 2037.0 2045.3 78571.0 82653.0 82803.2 83603.0 84081.6 10567.0 10676.8 10730.4 10847.6 10962.6 15142.9 15187.8 15189.7 15222.8 15258.0 7850.4 8052.9 8074.7 8105.7 8247.5 7749.0 7769.3 7785.5 7865.1 7882.4 4575.2 4659.7 4676.3 4678.9 4701.0 1948.5 1956.1 1990.5 1991.3 2005.1 933.4 967.8 1051.8 1061.9 1063.4 18331.5 18954.8 19698.6 19716.0 19772.5 991.4 1003.8 1020.7 1036.6 1069.6 10476.5 11075.3 11086.3 11142.3 11173.7 505521.0 509091.0 510891.0 520081.0 521636.0 90974.5 91805.6 92837.0 93553.5 94792.0 970.9 984.1 995.7 998.9 1007.5 16827.3 17160.0 17261.3 17343.2 17581.1 40256.4 41026.2 41144.0 41274.0 41579.2 55388.0 55923.4 56344.0 56458.4 56679.0 6470.0 8097.2 8406.2 8594.6 8759.3 12895.8 12939.8 13001.7 13018.2 13129.7 11299.9 11333.8 11571.9 11603.8 11606.4 11125.2 11152.4 11213.9 11308.2 11321.3 11680.5 11701.5 11729.7 11814.9 11866.4 8367.2 8367.4 8445.8 8451.1 8678.8 8416.0 10489.4 11547.1 11672.9 11715.1 23:36:47 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | [#3] mootools.html Cycles:180 Average:5935.90 Median:466.91 stddev:3440.04 (736.8%) stddev-sans-first:3433.33 23:36:47 INFO - PROCESS | 26752 | Values: 1471.4 1526.5 1644.0 1725.8 1733.4 7815.9 8585.4 8674.2 9245.5 9268.4 8621.9 8771.5 8936.5 8961.0 8998.0 2324.4 2363.7 2379.9 2381.5 2389.3 2257.6 2287.1 2292.1 2305.1 2321.8 2301.9 2302.5 2302.9 2337.0 2357.3 2258.5 2284.8 2290.1 2294.7 2306.1 2275.9 2295.9 2298.7 2305.1 2307.5 8756.6 8767.6 8814.8 8827.7 8859.0 5110.2 5226.6 5269.7 5273.9 5287.8 3221.8 3389.2 3406.4 3515.5 3537.1 1122.9 1146.0 1157.8 1169.7 1176.4 12622.3 12707.7 12729.2 12812.0 12846.6 4582.6 4618.5 4720.2 4760.6 4767.3 10815.6 10821.8 10844.3 10850.5 10885.0 5168.5 5194.7 5221.3 5226.8 5246.0 4372.6 4776.2 4817.0 4927.0 4928.9 4112.3 4139.8 4167.6 4202.8 4258.9 1280.5 1299.1 1310.8 1321.4 1326.5 895.6 986.5 996.0 1043.2 1043.6 6019.2 6191.0 6236.9 6247.4 6254.8 465.7 468.2 470.6 474.3 477.0 4320.3 4364.8 4377.0 4391.5 4400.3 11151.9 11483.1 11537.6 11564.4 11572.2 10608.7 11027.8 11062.4 11399.9 11410.9 8350.4 8442.0 8505.5 8571.3 8593.4 5857.1 6122.8 6133.0 6208.2 6231.0 10144.9 10247.2 10509.6 10569.9 10571.8 10253.4 10509.8 10550.1 10632.4 10953.2 7380.7 7714.3 7993.4 8151.8 8284.7 8796.7 8845.5 8894.4 8921.1 8944.0 7934.6 7941.7 8012.4 8118.5 8221.2 7714.9 7748.4 7951.8 8144.6 8182.3 7184.4 7224.7 7235.3 7235.4 7246.8 5030.3 5038.4 5109.4 5124.5 5185.6 5255.4 5258.2 5284.3 5333.2 5400.2 23:36:47 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | [#4] prototype.html Cycles:180 Average:4863.41 Median:5486.92 stddev:1452.66 (26.5%) stddev-sans-first:1416.01 23:36:47 INFO - PROCESS | 26752 | Values: 312.9 327.4 333.4 333.7 335.1 5426.5 5437.6 5591.8 5598.8 5643.7 5478.6 5495.2 5521.6 5525.3 5529.3 4365.7 4382.6 4387.5 4393.5 4403.5 4031.9 4281.0 4296.8 4368.0 4401.9 4223.0 4224.5 4264.0 4296.9 4313.3 4303.7 4308.1 4317.9 4319.6 4327.7 3550.8 3781.8 3789.7 3790.5 3793.4 5251.9 5349.5 5356.8 5368.8 5387.4 4842.3 4860.3 4870.6 4873.8 4912.3 5560.2 5811.0 5842.5 5852.3 5852.3 4113.7 4115.1 4122.9 4137.5 4144.6 6006.3 6095.4 6118.3 6145.1 6177.3 4094.7 4172.4 4184.4 4190.4 4220.7 4243.7 4250.4 4250.7 4253.4 4263.9 4887.4 4895.9 4903.3 4905.8 4960.5 5794.0 5817.8 5874.7 5891.4 5894.3 1459.2 1460.7 1465.3 1468.0 1477.0 896.5 916.8 920.7 923.5 937.4 4814.4 4814.9 4958.9 5028.5 5117.7 5312.2 5353.0 5463.7 5496.3 5514.4 4991.2 5121.4 5140.5 5204.9 5698.5 3153.0 3200.2 3207.7 3210.3 3216.7 6004.4 6170.6 6242.9 6288.6 6311.0 6047.8 6150.4 6159.9 6166.8 6171.0 6155.5 6172.2 6203.3 6233.0 6243.3 5770.6 5942.6 5982.4 5985.3 5992.2 5936.2 5951.9 5960.4 5963.3 6008.2 5957.6 6206.3 6208.0 6239.7 6248.6 4184.5 4185.5 4188.4 4192.1 4212.0 6032.3 6091.4 6094.7 6098.3 6112.9 5447.8 5839.4 5864.2 5865.6 5924.3 5914.2 5920.5 5922.5 5934.6 5951.8 5581.7 5795.3 5803.9 5803.9 5872.1 5903.9 5905.2 5917.3 5960.3 5969.8 5728.3 5779.9 5788.9 5838.4 5844.7 23:36:47 INFO - PROCESS | 26752 | 23:36:47 INFO - PROCESS | 26752 | [#5] yui.html Cycles:180 Average:20845.19 Median:3944.93 stddev:29298.15 (742.7%) stddev-sans-first:29341.68 23:36:47 INFO - PROCESS | 26752 | Values: 800.5 829.7 842.2 845.6 859.1 15127.1 16119.5 16160.7 16426.0 16491.6 14375.8 14606.8 14661.9 14676.1 14697.6 792.5 806.9 825.8 830.1 838.4 829.9 833.2 837.1 838.0 838.4 862.9 868.5 870.9 871.7 875.8 864.2 869.5 870.6 870.9 871.3 633.0 634.5 635.9 637.1 637.3 15476.5 15496.1 15542.8 15550.4 15566.5 14604.6 14717.9 14809.3 14824.6 15067.2 12242.8 12403.6 12451.0 12579.5 12936.2 3762.3 3815.0 3855.1 3909.4 3980.5 79505.6 80147.2 80664.6 81361.0 81774.2 11033.0 11055.5 11178.4 11222.8 11365.7 21595.0 21823.0 21930.8 21960.0 22009.9 8464.9 8787.7 8801.0 8802.2 8832.6 4944.6 4945.9 4989.6 5043.4 5205.3 3556.9 3681.0 3684.7 3691.6 3698.6 590.8 608.6 610.6 620.3 620.3 663.9 770.4 783.7 790.0 796.9 10057.6 10085.7 10127.5 10178.4 10230.8 656.5 715.7 753.7 760.1 769.6 4598.4 4726.6 4754.2 4778.8 4850.4 68884.0 88558.6 90740.0 91851.0 106414.0 104761.5 106806.0 106955.0 108048.5 109908.0 90722.5 91074.0 91098.0 92326.0 93909.0 9676.7 9679.3 9759.3 9984.1 10025.7 51268.5 51450.0 51664.7 51860.0 53054.2 68099.3 76191.2 76270.0 78802.2 80232.0 13471.7 13495.9 13589.0 13684.6 14206.6 15478.9 15535.5 15719.4 16034.4 16199.5 13333.7 13760.0 13944.2 13961.3 13977.5 13430.0 13648.6 13758.4 13992.4 14498.3 13276.6 13504.4 13651.2 13821.2 13851.9 11196.6 11423.3 11597.9 11772.2 11805.3 10961.2 11367.5 11833.3 12065.9 12300.8 23:36:47 INFO - PROCESS | 26752 | -------- Summary: end -------- 23:36:47 INFO - PROCESS | 26752 | 23:36:48 INFO - TEST-INFO | 26752: exit 0 23:36:48 INFO - TEST-OK | dromaeo_css | took 1110052ms 23:36:48 INFO - TEST-START | kraken 23:36:48 INFO - operating with platform_type : linux_ 23:36:48 INFO - Initialising browser for kraken test... 23:36:48 INFO - TEST-INFO | started process 26986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplT7OF0/profile http://localhost:44140/getInfo.html) 23:36:52 INFO - PROCESS | 26986 | __metrics Screen width/height:1600/1200 23:36:52 INFO - PROCESS | 26986 | colorDepth:24 23:36:52 INFO - PROCESS | 26986 | Browser inner width/height: 1024/697 23:36:52 INFO - PROCESS | 26986 | __metrics 23:36:53 ERROR - PROCESS | 26986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:36:54 INFO - TEST-INFO | 26986: exit 0 23:36:54 INFO - Browser initialized. 23:36:54 INFO - Running cycle 1/1 for kraken test... 23:36:54 INFO - TEST-INFO | started process 27107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplT7OF0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:37:05 INFO - PROCESS | 27107 | RSS: Main: 166768640 23:37:05 INFO - PROCESS | 27107 | 23:37:08 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44140/tests/kraken/driver.html?testName=audio-beat-detection) 23:37:09 INFO - PROCESS | 27107 | RSS: Main: 171819008 23:37:09 INFO - PROCESS | 27107 | 23:37:12 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44140/tests/kraken/driver.html?testName=audio-dft) 23:37:12 INFO - PROCESS | 27107 | RSS: Main: 171200512 23:37:12 INFO - PROCESS | 27107 | 23:37:15 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44140/tests/kraken/driver.html?testName=audio-fft) 23:37:16 INFO - PROCESS | 27107 | RSS: Main: 166043648 23:37:16 INFO - PROCESS | 27107 | 23:37:18 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44140/tests/kraken/driver.html?testName=audio-oscillator) 23:37:19 INFO - PROCESS | 27107 | RSS: Main: 166637568 23:37:19 INFO - PROCESS | 27107 | 23:37:21 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:37:21 INFO - PROCESS | 27107 | RSS: Main: 166944768 23:37:21 INFO - PROCESS | 27107 | 23:37:24 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44140/tests/kraken/driver.html?testName=imaging-darkroom) 23:37:25 INFO - PROCESS | 27107 | RSS: Main: 167575552 23:37:25 INFO - PROCESS | 27107 | 23:37:29 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44140/tests/kraken/driver.html?testName=imaging-desaturate) 23:37:29 INFO - PROCESS | 27107 | RSS: Main: 165736448 23:37:29 INFO - PROCESS | 27107 | 23:37:32 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44140/tests/kraken/driver.html?testName=json-parse-financial) 23:37:33 INFO - PROCESS | 27107 | RSS: Main: 167231488 23:37:33 INFO - PROCESS | 27107 | 23:37:34 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:37:35 INFO - PROCESS | 27107 | RSS: Main: 167571456 23:37:35 INFO - PROCESS | 27107 | 23:37:37 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44140/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:37:37 INFO - PROCESS | 27107 | RSS: Main: 167620608 23:37:37 INFO - PROCESS | 27107 | 23:37:39 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:37:40 INFO - PROCESS | 27107 | RSS: Main: 168148992 23:37:40 INFO - PROCESS | 27107 | 23:37:43 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:37:43 INFO - PROCESS | 27107 | RSS: Main: 168415232 23:37:43 INFO - PROCESS | 27107 | 23:37:46 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:37:47 INFO - PROCESS | 27107 | RSS: Main: 168783872 23:37:47 INFO - PROCESS | 27107 | 23:37:48 INFO - PROCESS | 27107 | Cycle 1(1): loaded http://localhost:44140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44140/tests/kraken/driver.html?testName=ai-astar) 23:37:49 INFO - PROCESS | 27107 | RSS: Main: 169472000 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | __start_tp_report 23:37:49 INFO - PROCESS | 27107 | _x_x_mozilla_page_load 23:37:49 INFO - PROCESS | 27107 | _x_x_mozilla_page_load_details 23:37:49 INFO - PROCESS | 27107 | |i|pagename|runs| 23:37:49 INFO - PROCESS | 27107 | |0;ai-astar;113;106;110;115;112;112;110;113;112;111 23:37:49 INFO - PROCESS | 27107 | |1;audio-beat-detection;158;126;157;185;141;155;158;138;191;134 23:37:49 INFO - PROCESS | 27107 | |2;audio-dft;166;164;164;163;163;180;164;165;163;166 23:37:49 INFO - PROCESS | 27107 | |3;audio-fft;74;76;75;159;76;76;75;75;161;77 23:37:49 INFO - PROCESS | 27107 | |4;audio-oscillator;84;84;150;85;84;85;135;85;85;139 23:37:49 INFO - PROCESS | 27107 | |5;imaging-gaussian-blur;120;119;117;119;118;119;118;120;117;118 23:37:49 INFO - PROCESS | 27107 | |6;imaging-darkroom;149;148;149;148;148;149;148;147;148;147 23:37:49 INFO - PROCESS | 27107 | |7;imaging-desaturate;99;96;97;95;95;96;96;97;95;96 23:37:49 INFO - PROCESS | 27107 | |8;json-parse-financial;55;54;55;53;54;58;54;56;58;55 23:37:49 INFO - PROCESS | 27107 | |9;json-stringify-tinderbox;65;64;64;64;63;63;64;64;63;64 23:37:49 INFO - PROCESS | 27107 | |10;stanford-crypto-aes;80;81;80;83;84;82;82;88;104;82 23:37:49 INFO - PROCESS | 27107 | |11;stanford-crypto-ccm;132;140;134;128;127;123;123;128;151;124 23:37:49 INFO - PROCESS | 27107 | |12;stanford-crypto-pbkdf2;167;165;165;162;162;163;162;161;162;165 23:37:49 INFO - PROCESS | 27107 | |13;stanford-crypto-sha256-iterative;64;67;64;64;68;63;63;64;63;66 23:37:49 INFO - PROCESS | 27107 | __end_tp_report 23:37:49 INFO - PROCESS | 27107 | __start_cc_report 23:37:49 INFO - PROCESS | 27107 | _x_x_mozilla_cycle_collect,888 23:37:49 INFO - PROCESS | 27107 | __end_cc_report 23:37:49 INFO - PROCESS | 27107 | __startTimestamp1464935869146__endTimestamp 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | ------- Summary: start ------- 23:37:49 INFO - PROCESS | 27107 | Number of tests: 14 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.41 (2.2%) stddev-sans-first:2.49 23:37:49 INFO - PROCESS | 27107 | Values: 113.0 106.0 110.0 115.0 112.0 112.0 110.0 113.0 112.0 111.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:157.50 stddev:21.03 (13.4%) stddev-sans-first:22.26 23:37:49 INFO - PROCESS | 27107 | Values: 158.0 126.0 157.0 185.0 141.0 155.0 158.0 138.0 191.0 134.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#2] audio-dft Cycles:10 Average:165.80 Median:164.50 stddev:5.12 (3.1%) stddev-sans-first:5.43 23:37:49 INFO - PROCESS | 27107 | Values: 166.0 164.0 164.0 163.0 163.0 180.0 164.0 165.0 163.0 166.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.50 stddev:35.64 (47.2%) stddev-sans-first:37.18 23:37:49 INFO - PROCESS | 27107 | Values: 74.0 76.0 75.0 159.0 76.0 76.0 75.0 75.0 161.0 77.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.50 stddev:27.67 (32.7%) stddev-sans-first:28.60 23:37:49 INFO - PROCESS | 27107 | Values: 84.0 84.0 150.0 85.0 84.0 85.0 135.0 85.0 85.0 139.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:1.08 (0.9%) stddev-sans-first:1.00 23:37:49 INFO - PROCESS | 27107 | Values: 120.0 119.0 117.0 119.0 118.0 119.0 118.0 120.0 117.0 118.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 23:37:49 INFO - PROCESS | 27107 | Values: 149.0 148.0 149.0 148.0 148.0 149.0 148.0 147.0 148.0 147.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.23 (1.3%) stddev-sans-first:0.78 23:37:49 INFO - PROCESS | 27107 | Values: 99.0 96.0 97.0 95.0 95.0 96.0 96.0 97.0 95.0 96.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.69 (3.1%) stddev-sans-first:1.79 23:37:49 INFO - PROCESS | 27107 | Values: 55.0 54.0 55.0 53.0 54.0 58.0 54.0 56.0 58.0 55.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 23:37:49 INFO - PROCESS | 27107 | Values: 65.0 64.0 64.0 64.0 63.0 63.0 64.0 64.0 63.0 64.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:82.00 stddev:7.20 (8.8%) stddev-sans-first:7.44 23:37:49 INFO - PROCESS | 27107 | Values: 80.0 81.0 80.0 83.0 84.0 82.0 82.0 88.0 104.0 82.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:130.00 stddev:8.83 (6.8%) stddev-sans-first:9.36 23:37:49 INFO - PROCESS | 27107 | Values: 132.0 140.0 134.0 128.0 127.0 123.0 123.0 128.0 151.0 124.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:1.96 (1.2%) stddev-sans-first:1.58 23:37:49 INFO - PROCESS | 27107 | Values: 167.0 165.0 165.0 162.0 162.0 163.0 162.0 161.0 162.0 165.0 23:37:49 INFO - PROCESS | 27107 | 23:37:49 INFO - PROCESS | 27107 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.00 stddev:1.78 (2.8%) stddev-sans-first:1.87 23:37:49 INFO - PROCESS | 27107 | Values: 64.0 67.0 64.0 64.0 68.0 63.0 63.0 64.0 63.0 66.0 23:37:49 INFO - PROCESS | 27107 | -------- Summary: end -------- 23:37:49 INFO - PROCESS | 27107 | 23:37:50 INFO - TEST-INFO | 27107: exit 0 23:37:50 INFO - TEST-OK | kraken | took 61711ms 23:37:50 INFO - SUITE-END | took 1171s 23:37:50 INFO - Completed test suite (00:19:31) 23:37:50 INFO - javascript benchmark 23:37:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7253.877760559961, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.1726242545724, 3165.0, 3187.6015498062748, 3202.343519578487, 3213.582234309541, 5461.918071228934, 5465.890682186359, 5479.726013699314, 5576.5817563682685, 5596.748146333425, 5383.138697808351, 5471.863203419916, 5522.447755224475, 5539.473749993755, 5650.124230744231, 4977.377827771537, 5004.12427825131, 5093.949060509403, 5143.408508021569, 5175.922361164586, 828.1757649878317, 4938.506149385069, 5002.24966255061, 5018.498150184989, 5068.189089745623, 4986.351774269358, 5015.247712843066, 5026.773795179226, 5042.117629414856, 5064.2403639454005, 5045.0, 5047.974760126176, 5059.06407314648, 5076.873078173038, 5105.974470127626, 4991.700497970133, 5020.4226513951, 5029.748512574393, 5055.87360315995, 5066.214736715815, 5479.287692599976, 5497.890042199134, 5508.9724551376985, 5509.669419834822, 5556.027695153332, 5749.281339832521, 5938.198343223653, 5944.881102377972, 5957.136215248808, 5968.492678122365, 5984.251968503937, 6034.155218269446, 6047.274327080779, 6058.4244496772735, 6113.480354169901, 5584.497395234448, 5599.860003499904, 5600.719964001824, 5606.635568688022, 5621.634593751393, 5902.232709747791, 6027.065804800263, 6078.9361861674915, 6184.041473571604, 6196.3803619638575, 5850.707464626752, 5852.619579727304, 5856.531477481792, 5872.324682661463, 5874.295084589877, 5992.43071908168, 5998.610090344114, 5999.730012149376, 6009.06859436788, 6023.367546407564, 5906.852328691731, 5919.816036792658, 5921.555883308769, 5956.880862382728, 5976.551758618121, 5923.052311630118, 5987.820365388958, 5993.160957465958, 5998.400159983967, 6007.339192688801, 4381.430414046217, 4509.436320459942, 4509.864704058818, 4532.7280363178315, 4573.222552166139, 3922.3528117860806, 3948.269570129535, 3993.1414745829206, 4019.5980401960155, 4023.295923213426, 5598.300212473441, 5667.574931880043, 5686.943130568724, 5692.57305702074, 5722.942770572325, 5836.503897168704, 6010.0, 6030.095485677096, 6042.425969532887, 6043.7280322385595, 5662.292213473316, 5708.80019199326, 5727.0550359190265, 5731.739017416162, 5755.3381361144, 5128.076946149654, 5157.381114266312, 5161.535461808456, 5166.844994650167, 5179.974100129475, 5931.495822855106, 6106.582013105394, 6169.2288463942, 6220.875582488325, 6264.436200741955, 6015.699215039318, 6023.186869772525, 6049.455549000611, 6050.969745151246, 6105.786297479567, 6189.141925996568, 6200.286966998672, 6244.250689917239, 6244.843878903063, 6250.124982502544, 5690.544756419394, 5875.353711091862, 5917.230760001173, 5941.9405805943115, 5989.880202396015, 6024.548158888013, 6038.607490513103, 6041.516678665784, 6051.062085376773, 6085.0, 5803.622764520293, 5813.447722466359, 5847.970760146172, 5865.061590145556, 5886.557793340659, 5555.666660000413, 5786.045302525036, 5826.067829147486, 5867.266591676041, 5898.439648233411, 5719.57103217252, 5774.39368866263, 5795.971020144872, 5809.30288365382, 5825.854353641193, 5816.040353341651, 5830.883382332245, 5863.648181108976, 5930.288365396007, 5944.762209511571, 5544.528715059104, 5624.718764061862, 5671.858203544944, 5674.120511320752, 5748.022836117786], "value": 5459.150506209293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.5394830187548, 602.7769725201676, 609.987800243995, 639.7121295417062, 663.860589276252, 39633.405498917506, 40373.79813100934, 43896.0, 44312.77843610785, 44430.55569444304, 44520.554794452044, 44683.329750053774, 44875.10249795002, 44990.77504612481, 45314.54685453144, 8582.699605513793, 8681.348898832613, 8726.38915275931, 8784.297256219486, 8789.0, 8853.070427605073, 9014.188723014928, 9020.729378118667, 9026.774330641754, 9026.909730902706, 8901.376903616749, 8958.731238062868, 9004.8649270261, 9042.86435703465, 9102.954485227598, 8750.993635731877, 8812.779680508007, 8876.112388761137, 8878.822423551557, 8928.687495937611, 8862.468251904906, 8959.37284390093, 9027.14242146995, 9029.593668284877, 9046.502442365667, 41613.0, 42182.78908605468, 42414.57585424137, 42461.0, 42491.0, 2974.181278688858, 3464.9653503464897, 3474.4961980512685, 3538.8761393351365, 3625.2024554597947, 31377.8431107843, 31468.842655786575, 31484.842575787203, 31628.841855790575, 31718.0, 3668.816559172031, 3711.814409279525, 3712.888613341604, 3731.9626803731885, 3926.705497087701, 308352.0, 308471.0, 308740.0, 311674.0, 311953.4402327997, 30938.381232375228, 31634.209144771103, 31859.52210716841, 34704.0, 35123.297534049176, 36572.0, 36803.079923001605, 36828.631713682524, 36910.8154459226, 36993.445098323544, 15170.31733571992, 15178.848211517965, 15266.770998435033, 15324.846751532565, 15415.997960132556, 12873.485060597472, 12953.870461295266, 12973.740525189443, 12976.740465190644, 13089.738205235843, 8221.218984196492, 8259.091499935003, 8286.0, 8307.376946728898, 8348.248657620721, 3231.9030429087165, 3276.770626056201, 3305.190228394011, 3309.321589074234, 3312.668733126668, 1089.4062735809002, 1125.6004118537965, 1133.3369978562632, 1162.947667354954, 1169.216624861345, 32713.34573308568, 32820.507692384635, 32968.34063318768, 33058.17354566155, 33110.17224569405, 1140.406988366045, 1158.1603337580186, 1180.5749930025183, 1210.425048102162, 1302.5310888080282, 17083.060431676127, 17456.301747930196, 17544.736828947574, 17572.38496652611, 17636.647267054588, 535645.0, 537048.0, 538362.0, 538628.0, 541076.0, 59199.0, 59899.70050149722, 60234.698826506465, 60333.39666603366, 60413.69793151006, 1349.6828245362333, 1385.9584212473642, 1396.9662449787083, 1424.1526291856328, 1424.5939907126626, 31334.74661013534, 32481.0, 32637.0, 32885.47664747346, 32890.0, 52004.0, 52174.47825521696, 52260.0, 52602.47397525976, 52616.0, 433224.0, 433440.0, 434454.0, 436038.0, 436521.0, 28047.579286310312, 28185.295367615974, 28537.14388568346, 28696.713032869404, 28794.712052879204, 50004.0, 50327.74836125796, 50444.0, 50887.0, 51790.482095178566, 42582.0, 43064.0, 43358.56641433672, 43682.34476482792, 43793.78103109464, 41298.0, 41362.172756545304, 41935.580644194386, 42140.157196855274, 42433.44498201216, 32426.35147297088, 41201.1759764809, 41402.0, 41427.171456571305, 41909.0, 33461.33077338391, 38082.809585951894, 38203.23593528169, 38535.80732096434, 38543.614563855124, 29027.709722902502, 29109.854450728457, 29188.56217156702, 29200.561991569717, 29587.260318492208], "value": 18751.094841675676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.5799799219855, 395.15831279374925, 398.3705744923022, 399.8920291521289, 406.94099355593437, 13674.863251367484, 18106.18522166504, 18776.71834922477, 19591.510212244702, 19654.803451965476, 18514.53713657159, 18515.259389624433, 18753.812461875375, 19714.50713732154, 19876.602467950634, 5570.944290557103, 5673.574481913853, 5674.978503869302, 5790.855228619297, 5809.3900140485275, 5618.353889302742, 5663.037283661787, 5730.856728581798, 5737.196792449061, 5740.167675687044, 5233.110371236899, 5570.192322113291, 5574.581906357019, 5705.286839145107, 5749.511291540224, 5560.582956278255, 5612.41069687681, 5616.691081990489, 5675.0, 6298.811035668938, 5593.552515798727, 5595.328560572757, 5627.521660658849, 5630.296212973379, 5656.4060773618585, 13064.0, 13244.668883277898, 13687.0, 13721.588352349345, 13775.0, 2144.7560414959285, 2172.7935846094597, 2218.900149493277, 2372.750861159588, 2411.7097352916107, 9643.758906027335, 9707.757306067335, 10317.638882639072, 10464.42445665488, 10595.205359597983, 1908.1031914999928, 1966.8229859312587, 2010.859239853211, 2036.9694454583193, 2045.3148195354424, 78571.0, 82653.0, 82803.17196828075, 83602.98382097033, 84081.57959210227, 10567.0, 10676.839847402296, 10730.356178629307, 10847.620333288298, 10962.56149754001, 15142.924285378502, 15187.772183417257, 15189.696206075816, 15222.847771522365, 15258.0, 7850.411219158586, 8052.919470805217, 8074.74841399584, 8105.716299929592, 8247.463914845515, 7749.0, 7769.261920117579, 7785.532868027936, 7865.134835168127, 7882.408819338572, 4575.24508456101, 4659.673822832437, 4676.3453116563705, 4678.883027924261, 4700.976495117503, 1948.503131701407, 1956.1392987085637, 1990.4526255279914, 1991.3030439346112, 2005.1377907499623, 933.4399360383851, 967.7580604848788, 1051.7896420715888, 1061.9009325348227, 1063.3991794636006, 18331.541711457052, 18954.81045189558, 19698.60602787965, 19716.0, 19772.505687357643, 991.3952488981715, 1003.7590978165334, 1020.7295066807302, 1036.6475398364591, 1069.5828626835541, 10476.52855621499, 11075.280106793032, 11086.279391839505, 11142.27575207609, 11173.72065698364, 505521.0, 509091.0, 510891.0, 520081.0, 521636.0, 90974.54512727527, 91805.62291565632, 92837.0, 93553.53223233977, 94792.0, 970.8543718442149, 984.07988530724, 995.7354160216485, 998.9350692204983, 1007.4559737741538, 16827.326906923587, 17160.0, 17261.309547618457, 17343.2195551198, 17581.120943952494, 40256.396154057125, 41026.1794764109, 41144.0, 41274.0, 41579.16841663211, 55388.0, 55923.440765591826, 56344.0, 56458.43541564532, 56679.0, 6470.029495575702, 8097.2307630774985, 8406.243438090602, 8594.570271486526, 8759.255463285437, 12895.806562901376, 12939.805902911652, 13001.674958126123, 13018.15382000167, 13129.737405252032, 11299.943500282774, 11333.773324533298, 11571.884281157081, 11603.781602931907, 11606.361650109326, 11125.221234513507, 11152.44237788091, 11213.943930280622, 11308.208425410472, 11321.320720756781, 11680.47437865281, 11701.531938722695, 11729.706757331134, 11814.881851181723, 11866.40667966581, 8367.205115514016, 8367.414281000514, 8445.831083378422, 8451.070382257823, 8678.78303042429, 8415.990081190052, 10489.370637761758, 11547.076233901436, 11672.941635291769, 11715.062794976551], "value": 9006.999235591094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.4187895781167, 1526.503886236973, 1643.9835601643988, 1725.818789027153, 1733.4279687703051, 7815.921840781591, 8585.399022068457, 8674.175953284435, 9245.537723113852, 9268.443893366395, 8621.913780862189, 8771.47371157731, 8936.508492032935, 8961.0, 8997.955010224956, 2324.4421338878674, 2363.657269695893, 2379.8572085674828, 2381.523695260946, 2389.283215035491, 2257.582347265761, 2287.0737351372723, 2292.106078629336, 2305.0779688124717, 2321.767823217682, 2301.9424514387106, 2302.470431800687, 2302.8848557572137, 2337.041812856729, 2357.316378250314, 2258.5369999150134, 2284.794368506834, 2290.0725206291477, 2294.6672732453785, 2306.0660432524855, 2275.9317220483413, 2295.908163673451, 2298.747137814839, 2305.0664480885266, 2307.515421761432, 8756.60595273208, 8767.561621918878, 8814.823703525957, 8827.69103081389, 8858.955705221497, 5110.233464980245, 5226.581873450153, 5269.710165940872, 5273.894522109575, 5287.814926477555, 3221.774475786696, 3389.1527118220447, 3406.386850366933, 3515.455104458813, 3537.0980399998093, 1122.9057807189615, 1145.9601908602617, 1157.7742340243656, 1169.7251145980688, 1176.394157009141, 12622.305773182472, 12707.745845083138, 12729.236245825281, 12812.0, 12846.550370736979, 4582.564656357641, 4618.49196588375, 4720.197566413718, 4760.571548560646, 4767.332573439721, 10815.621453249098, 10821.783564328827, 10844.349339039683, 10850.45747712627, 10885.0, 5168.483151684802, 5194.740262986836, 5221.269022336875, 5226.790928362899, 5246.029484545371, 4372.628326592276, 4776.188048031843, 4817.0365926814075, 4926.975365123151, 4928.866360736979, 4112.280350938574, 4139.834406623701, 4167.604077612622, 4202.810873510699, 4258.936115958263, 1280.4875013068643, 1299.051692264652, 1310.8361454818148, 1321.4251800466827, 1326.5158217250635, 895.5925054100369, 986.4525188520297, 996.0, 1043.1811028342715, 1043.639944219243, 6019.187409699634, 6191.0, 6236.906446403307, 6247.437730604177, 6254.843628909222, 465.6507619285536, 468.1760102220049, 470.5509408542225, 474.3335613463021, 476.9785359658824, 4320.265554855682, 4364.781760911942, 4376.978115109468, 4391.538888416734, 4400.339949007611, 11151.888481115086, 11483.138764592522, 11537.596184133683, 11564.363959982113, 11572.189946703818, 10608.734781630366, 11027.83458248127, 11062.39156846365, 11399.943000284946, 11410.885891140982, 8350.373721970876, 8441.95779021101, 8505.53219572917, 8571.314294856396, 8593.398462107592, 5857.121431785095, 6122.846928826815, 6132.969335153474, 6208.2239720034995, 6230.968845155745, 10144.898551014396, 10247.180225581786, 10509.579616815241, 10569.947150264506, 10571.841422378517, 10253.384796912209, 10509.842352364567, 10550.103241224275, 10632.41521716313, 10953.233273670767, 7380.667869945758, 7714.305712485679, 7993.360531157377, 8151.755447336589, 8284.668613255402, 8796.692115775917, 8845.51349675774, 8894.377393582387, 8921.06328835463, 8943.955280223558, 7934.60326983637, 7941.722039728582, 8012.399070069651, 8118.512889226666, 8221.17788221173, 7714.922850771421, 7748.380129589506, 7951.801204969922, 8144.55204963709, 8182.263596276363, 7184.389326907062, 7224.674889630084, 7235.3488186063505, 7235.421166306577, 7246.818829529304, 5030.295758593873, 5038.445770965264, 5109.386873575195, 5124.487551244845, 5185.559227465707, 5255.369355677343, 5258.158694608845, 5284.260921603799, 5333.173358129496, 5400.162974738922], "value": 4650.415384021881, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8826689991253, 327.41066081054106, 333.36826713378156, 333.6663336663337, 335.1019268360794, 5426.457354264571, 5437.6465529740635, 5591.776328946842, 5598.804041858536, 5643.661380317179, 5478.616496845212, 5495.230667706514, 5521.641093328931, 5525.254090697755, 5529.30883639545, 4365.694401391896, 4382.561743825624, 4387.451568553931, 4393.538678438766, 4403.546829546242, 4031.9395209071886, 4280.97859510702, 4296.785160741966, 4367.951691594027, 4401.889952751175, 4222.9577704222875, 4224.471941007374, 4264.0, 4296.892577685568, 4313.331433627793, 4303.698741088125, 4308.095299987007, 4317.913641727164, 4319.632831209351, 4327.740335579875, 3550.804705741183, 3781.8487260509546, 3789.7347185697013, 3790.450384694204, 3793.3930571108767, 5251.921221181686, 5349.491798279158, 5356.758945847408, 5368.8389348319615, 5387.353517577876, 4842.346283251751, 4860.295257187723, 4870.561649451531, 4873.829415970459, 4912.256149067101, 5560.165975103726, 5810.970945145289, 5842.4741773240185, 5852.297724273115, 5852.297724273115, 4113.670906327487, 4115.115250221217, 4122.896927576835, 4137.46212992309, 4144.590839114716, 6006.279246490405, 6095.359987201325, 6118.3269840317525, 6145.108959200891, 6177.320494745574, 4094.651954583834, 4172.415861779354, 4184.4141820145205, 4190.392393102983, 4220.662347012231, 4243.745375277494, 4250.426192463978, 4250.723702959298, 4253.383259427365, 4263.936040959388, 4887.413510378707, 4895.877603059952, 4903.33804936329, 4905.754712264444, 4960.454350021495, 5793.978571856034, 5817.796377126865, 5874.676892770854, 5891.440313170242, 5894.263217097863, 1459.1682740837832, 1460.7443697353133, 1465.2966576043345, 1468.0, 1476.9704605908037, 896.4576431259125, 916.7983043730369, 920.6869664314165, 923.5243849417556, 937.3906960475746, 4814.350062741555, 4814.8796280093275, 4958.884251043559, 5028.547430731179, 5117.74411279442, 5312.167302280707, 5353.009693206769, 5463.699496527729, 5496.31296087989, 5514.420985796514, 4991.226359914219, 5121.359830021247, 5140.537351638296, 5204.947950520522, 5698.461415417814, 3152.9684703152675, 3200.1679563313705, 3207.711305982473, 3210.293735378213, 3216.710496055366, 6004.369541198112, 6170.598911070766, 6242.906356404657, 6288.5598008139905, 6310.968445157745, 6047.762327938691, 6150.446459818549, 6159.907601385983, 6166.81499555014, 6170.969145154246, 6155.4767844732805, 6172.197614310201, 6203.2556093269095, 6233.0338797486465, 6243.344448832807, 5770.571568438505, 5942.64344139353, 5982.4316689914385, 5985.341612422717, 5992.161097446274, 5936.198613187337, 5951.910721339097, 5960.433758792908, 5963.254593175853, 6008.24896887889, 5957.582969192115, 6206.348333424925, 6208.037754148114, 6239.688015599111, 6248.593841400295, 4184.476940382452, 4185.476815398075, 4188.392683061, 4192.0925978679015, 4211.978940105279, 6032.276126864629, 6091.42131497507, 6094.7257373417415, 6098.329183789869, 6112.908306375319, 5447.782088716407, 5839.445252700986, 5864.208331875142, 5865.618734782396, 5924.318703348998, 5914.201582786441, 5920.526357891445, 5922.496587789914, 5934.6142500737315, 5951.779885123626, 5581.665100094007, 5795.275590551181, 5803.883922321615, 5803.941960580509, 5872.0898260769645, 5903.940960590511, 5905.202797622438, 5917.319508256605, 5960.314563825215, 5969.791057312973, 5728.283964504437, 5779.8555036124435, 5788.942110578841, 5838.416158384128, 5844.736986835687], "value": 4391.6868494765795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.5036877136173, 829.6639860856352, 842.2083241752756, 845.5645342648534, 859.1451505751778, 15127.092374457527, 16119.516414507569, 16160.676786464264, 16426.0, 16491.58771030725, 14375.784363234534, 14606.780898286534, 14661.926690366534, 14676.119432834037, 14697.559073227794, 792.5442870349558, 806.8749343851683, 825.7976795685065, 830.0744669693279, 838.4047326398264, 829.8838162657232, 833.2292629317888, 837.0624900111883, 837.9706710265142, 838.3628442383771, 862.8533149364623, 868.452874688945, 870.8563087090622, 871.6556960000796, 875.8117004843957, 864.2265172670487, 869.5478351257342, 870.6343335798948, 870.9331069439917, 871.2637821041274, 632.968351582419, 634.511426201822, 635.9491240700733, 637.0698779781525, 637.2639601260552, 15476.535703928901, 15496.147711875843, 15542.844571554253, 15550.377984880592, 15566.533004009898, 14604.634884127876, 14717.92641036788, 14809.259537023107, 14824.629384265372, 15067.17130557819, 12242.755144897052, 12403.627891163189, 12451.0, 12579.496820127184, 12936.223826570342, 3762.3039737648623, 3814.9618503814886, 3855.0747820522874, 3909.354956432185, 3980.5024371953505, 79505.60247198727, 80147.19852801514, 80664.58006259822, 81361.0, 81774.18225817726, 11033.024627021308, 11055.502502387411, 11178.44107794607, 11222.831657525143, 11365.659030229106, 21595.0, 21823.0, 21930.780692192875, 21960.02359787627, 22009.889950550143, 8464.873026904601, 8787.692430764893, 8801.0, 8802.163794439519, 8832.55837208137, 4944.596747212368, 4945.876353091129, 4989.55094041538, 5043.394792624908, 5205.29728486657, 3556.928861422757, 3681.0, 3684.705223582107, 3691.557013158438, 3698.6301369863336, 590.8345663214221, 608.5983251054283, 610.5970059760537, 620.2990620598785, 620.3083561828529, 663.8871391863298, 770.4067867741919, 783.7021931666045, 789.9684012639545, 796.8645330293864, 10057.59769609222, 10085.747856303504, 10127.544260508295, 10178.389296642225, 10230.846537301946, 656.474820143883, 715.6564848872571, 753.7173559915032, 760.1448370583093, 769.5575044349522, 4598.402207712976, 4726.645501587394, 4754.165378747827, 4778.832740854054, 4850.442199147073, 68884.0, 88558.55720721355, 90740.0, 91851.0, 106414.0, 104761.47619261855, 106806.0, 106955.0, 108048.45975770228, 109908.0, 90722.54638726896, 91074.0, 91098.0, 92326.03144202416, 93909.0, 9676.70969870905, 9679.322447428613, 9759.268054895769, 9984.051515106054, 10025.749356266151, 51268.487315127866, 51450.0, 51664.741676292884, 51860.0, 53054.204186938, 68099.31900681127, 76191.23808761842, 76270.0, 78802.21197788179, 80232.0, 13471.663208419868, 13495.865041349462, 13589.0, 13684.589462316146, 14206.644833879236, 15478.9226053869, 15535.533933981998, 15719.417490199712, 16034.438794642132, 16199.514014579581, 13333.66665833362, 13759.966470746916, 13944.16335019902, 13961.301934903011, 13977.510787122403, 13430.040724116654, 13648.590542283748, 13758.380872860545, 13992.440302387791, 14498.347574358968, 13276.601701948957, 13504.392302346221, 13651.249181295125, 13821.239831809347, 13851.930740346637, 11196.608118715805, 11423.314601123959, 11597.942010289895, 11772.234804737665, 11805.291682499077, 10961.232713709964, 11367.54529818831, 11833.290002599872, 12065.879341206475, 12300.81548776787], "value": 7736.176096167619, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 110.0, 115.0, 112.0, 112.0, 110.0, 113.0, 112.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 157.0, 185.0, 141.0, 155.0, 158.0, 138.0, 191.0, 134.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 163.0, 163.0, 180.0, 164.0, 165.0, 163.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 159.0, 76.0, 76.0, 75.0, 75.0, 161.0, 77.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 150.0, 85.0, 84.0, 85.0, 135.0, 85.0, 85.0, 139.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 117.0, 119.0, 118.0, 119.0, 118.0, 120.0, 117.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 97.0, 95.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 54.0, 58.0, 54.0, 56.0, 58.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 83.0, 84.0, 82.0, 82.0, 88.0, 104.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 140.0, 134.0, 128.0, 127.0, 123.0, 123.0, 128.0, 151.0, 124.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 165.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 64.0, 64.0, 68.0, 63.0, 63.0, 64.0, 63.0, 66.0], "value": 64.6, "unit": "score"}]}]} 23:37:50 INFO - Return code: 0 23:37:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:37:50 ERROR - # TBPL SUCCESS # 23:37:50 INFO - Running post-action listener: _resource_record_post_action 23:37:50 INFO - ##### 23:37:50 INFO - ##### Finished run-tests step (success) 23:37:50 INFO - ##### 23:37:50 INFO - Running post-run listener: _resource_record_post_run 23:37:50 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 0; Write bytes: 542986240; Read time: 0; Write time: 462512 23:37:50 INFO - TinderboxPrint: CPU usage
13.5% 23:37:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:37:50 INFO - TinderboxPrint: I/O write bytes / time
542,986,240 / 462,512 23:37:50 INFO - TinderboxPrint: CPU idle
8,209.2 (86.5%) 23:37:50 INFO - TinderboxPrint: CPU user
1,228.1 (12.9%) 23:37:50 INFO - TinderboxPrint: Swap in / out
0 / 0 23:37:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247488512; Read time: 0; Write time: 232152 23:37:50 INFO - run-tests - Wall time: 1173s; CPU: 14.0%; Read bytes: 0; Write bytes: 286629888; Read time: 0; Write time: 229220 23:37:51 INFO - Running post-run listener: _upload_blobber_files 23:37:51 INFO - Blob upload gear active. 23:37:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:37:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:37:51 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'] 23:37:51 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 23:37:51 INFO - (blobuploader) - INFO - Open directory for files ... 23:37:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:37:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:37:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:52 INFO - (blobuploader) - INFO - Done attempting. 23:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:56 INFO - (blobuploader) - INFO - Done attempting. 23:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:57 INFO - (blobuploader) - INFO - Done attempting. 23:37:57 INFO - (blobuploader) - INFO - Iteration through files over. 23:37:57 INFO - Return code: 0 23:37:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:37:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:37:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b6939de95dc86ad4a1d7a2152b540a30627e92f73060d8644e31f17ea86fcb047113108cce9e84149940be7760fcf4f1b2a82b19143c944341f01feb0ff858c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad71f2b6cf4b043a31d5d747bcd02e342bc25fd2a9a91b3dbc64a830da542917cca149389c50465ed0d2c6012a8775fca3f8a13df99033b8daff794c54ec4208", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba2b2b172735f19b4f98483b7f73e22ad9dbf080ae1991f52a67d7abbaa049b922264a18812e52311e52d419a47f87768891c587b9a9812af54d785d537cbd46"} 23:37:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:37:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:37:57 INFO - Contents: 23:37:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b6939de95dc86ad4a1d7a2152b540a30627e92f73060d8644e31f17ea86fcb047113108cce9e84149940be7760fcf4f1b2a82b19143c944341f01feb0ff858c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad71f2b6cf4b043a31d5d747bcd02e342bc25fd2a9a91b3dbc64a830da542917cca149389c50465ed0d2c6012a8775fca3f8a13df99033b8daff794c54ec4208", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba2b2b172735f19b4f98483b7f73e22ad9dbf080ae1991f52a67d7abbaa049b922264a18812e52311e52d419a47f87768891c587b9a9812af54d785d537cbd46"} 23:37:57 INFO - Running post-run listener: copy_logs_to_upload_dir 23:37:57 INFO - Copying logs to upload dir... 23:37:57 INFO - mkdir: /builds/slave/test/build/upload/logs 23:37:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.651507 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-02 23:37:56.510725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 23:37:56.513920) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404 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/4b6939de95dc86ad4a1d7a2152b540a30627e92f73060d8644e31f17ea86fcb047113108cce9e84149940be7760fcf4f1b2a82b19143c944341f01feb0ff858c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad71f2b6cf4b043a31d5d747bcd02e342bc25fd2a9a91b3dbc64a830da542917cca149389c50465ed0d2c6012a8775fca3f8a13df99033b8daff794c54ec4208", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba2b2b172735f19b4f98483b7f73e22ad9dbf080ae1991f52a67d7abbaa049b922264a18812e52311e52d419a47f87768891c587b9a9812af54d785d537cbd46"} build_url:https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/f6EsUCYPS1uWaTRL0VQQnQ/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/4b6939de95dc86ad4a1d7a2152b540a30627e92f73060d8644e31f17ea86fcb047113108cce9e84149940be7760fcf4f1b2a82b19143c944341f01feb0ff858c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad71f2b6cf4b043a31d5d747bcd02e342bc25fd2a9a91b3dbc64a830da542917cca149389c50465ed0d2c6012a8775fca3f8a13df99033b8daff794c54ec4208", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba2b2b172735f19b4f98483b7f73e22ad9dbf080ae1991f52a67d7abbaa049b922264a18812e52311e52d419a47f87768891c587b9a9812af54d785d537cbd46"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 23:37:56.539036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 23:37:56.539362) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1464933935.602465-1194221404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 23:37:56.624377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 23:37:56.624711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 23:37:56.624999) ========= ========= Total master_lag: 0.18 =========