builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1464028639.24 results: success (0) buildid: 20160523105048 builduid: c7e295274eec4c33b0983b4de210b382 revision: 60435b82caee3a0c05466ff2249a574df57214e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.241308) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.242273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.242989) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.263989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.264284) ========= 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=fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 11:37:20-- 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% 35.8M=0s 2016-05-23 11:37:20 (35.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137628 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.418538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.419240) ========= 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=fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016442 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.472086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:19.472896) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60435b82caee3a0c05466ff2249a574df57214e6 --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 60435b82caee3a0c05466ff2249a574df57214e6 --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=fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 11:37:20,915 truncating revision to first 12 chars 2016-05-23 11:37:20,915 Setting DEBUG logging. 2016-05-23 11:37:20,915 attempt 1/10 2016-05-23 11:37:20,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60435b82caee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 11:37:21,163 unpacking tar archive at: fx-team-60435b82caee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:20.024567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:20.024958) ========= script_repo_revision: 60435b82caee3a0c05466ff2249a574df57214e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:20.025410) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:20.025729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:37:20.039195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-23 11:37:20.039505) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:37:21 INFO - MultiFileLogger online at 20160523 11:37:21 in /builds/slave/test 11:37:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:37:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:37:21 INFO - {'append_to_log': False, 11:37:21 INFO - 'base_work_dir': '/builds/slave/test', 11:37:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:37:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:37:21 INFO - 'branch': 'Fx-Team-Non-PGO', 11:37:21 INFO - 'buildbot_json_path': 'buildprops.json', 11:37:21 INFO - 'config_files': ('talos/linux_config.py',), 11:37:21 INFO - 'default_actions': ('clobber', 11:37:21 INFO - 'read-buildbot-config', 11:37:21 INFO - 'download-and-extract', 11:37:21 INFO - 'populate-webroot', 11:37:21 INFO - 'create-virtualenv', 11:37:21 INFO - 'install', 11:37:21 INFO - 'run-tests'), 11:37:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:37:21 INFO - 'download_minidump_stackwalk': True, 11:37:21 INFO - 'download_symbols': 'ondemand', 11:37:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:37:21 INFO - 'tooltool.py': '/tools/tooltool.py', 11:37:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:37:21 INFO - '/tools/misc-python/virtualenv.py')}, 11:37:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:37:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:37:21 INFO - 'installer_path': 'installer.exe', 11:37:21 INFO - 'log_level': 'info', 11:37:21 INFO - 'log_name': 'talos', 11:37:21 INFO - 'log_to_console': True, 11:37:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:37:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:37:21 INFO - 'opt_config_files': (), 11:37:21 INFO - 'pip_index': False, 11:37:21 INFO - 'sps_profile': False, 11:37:21 INFO - 'sps_profile_interval': 0, 11:37:21 INFO - 'suite': 'dromaeojs', 11:37:21 INFO - 'system_bits': '32', 11:37:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:37:21 INFO - 'title': 'talos-linux64-ix-048', 11:37:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:37:21 INFO - 'use_talos_json': True, 11:37:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:37:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:37:21 INFO - 'work_dir': 'build'} 11:37:21 INFO - ##### 11:37:21 INFO - ##### Running clobber step. 11:37:21 INFO - ##### 11:37:21 INFO - Running pre-action listener: _resource_record_pre_action 11:37:21 INFO - Running main action method: clobber 11:37:21 INFO - rmtree: /builds/slave/test/build 11:37:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:37:22 INFO - Running post-action listener: _resource_record_post_action 11:37:22 INFO - ##### 11:37:22 INFO - ##### Finished clobber step (success) 11:37:22 INFO - ##### 11:37:22 INFO - ##### 11:37:22 INFO - ##### Running read-buildbot-config step. 11:37:22 INFO - ##### 11:37:22 INFO - Running pre-action listener: _resource_record_pre_action 11:37:22 INFO - Running main action method: read_buildbot_config 11:37:22 INFO - Using buildbot properties: 11:37:22 INFO - { 11:37:22 INFO - "project": "", 11:37:22 INFO - "product": "firefox", 11:37:22 INFO - "script_repo_revision": "production", 11:37:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:37:22 INFO - "repository": "", 11:37:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:37:22 INFO - "buildid": "20160523105048", 11:37:22 INFO - "pgo_build": "False", 11:37:22 INFO - "basedir": "/builds/slave/test", 11:37:22 INFO - "buildnumber": 2996, 11:37:22 INFO - "slavename": "talos-linux64-ix-048", 11:37:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:37:22 INFO - "platform": "ubuntu64_hw", 11:37:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:37:22 INFO - "branch": "fx-team", 11:37:22 INFO - "repo_path": "integration/fx-team", 11:37:22 INFO - "revision": "60435b82caee3a0c05466ff2249a574df57214e6", 11:37:22 INFO - "stage_platform": "linux64", 11:37:22 INFO - "builduid": "c7e295274eec4c33b0983b4de210b382", 11:37:22 INFO - "slavebuilddir": "test" 11:37:22 INFO - } 11:37:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:37:22 INFO - Running post-action listener: _resource_record_post_action 11:37:22 INFO - ##### 11:37:22 INFO - ##### Finished read-buildbot-config step (success) 11:37:22 INFO - ##### 11:37:22 INFO - ##### 11:37:22 INFO - ##### Running download-and-extract step. 11:37:22 INFO - ##### 11:37:22 INFO - Running pre-action listener: _resource_record_pre_action 11:37:22 INFO - Running main action method: download_and_extract 11:37:22 INFO - mkdir: /builds/slave/test/build/tests 11:37: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')]} 11:37:22 INFO - https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:37:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:37:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:37:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:23 INFO - Downloaded 1361 bytes. 11:37:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:37:23 INFO - Using the following test package requirements: 11:37:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:37:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:37:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:23 INFO - u'jsshell-linux-x86_64.zip'], 11:37:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:37:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:37:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:37:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:37:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:37:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:37:23 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')]} 11:37:23 INFO - https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:24 INFO - Downloaded 22814444 bytes. 11:37:24 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'] 11:37:24 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 11:37:25 INFO - Return code: 0 11:37:25 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 11:37:25 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')]} 11:37:25 INFO - https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:37:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:37:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:37:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:26 INFO - Downloaded 22814444 bytes. 11:37:26 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'] 11:37:26 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 11:37:28 INFO - Return code: 0 11:37: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')]} 11:37:28 INFO - https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:37:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:29 INFO - Downloaded 10840359 bytes. 11:37:29 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'] 11:37:29 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 11:37:29 INFO - Return code: 0 11:37:29 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')]} 11:37:29 INFO - https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/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 11:37:31 INFO - Downloaded 54811713 bytes. 11:37:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:37:31 INFO - mkdir: /builds/slave/test/properties 11:37:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:31 INFO - Contents: 11:37:31 INFO - build_url:https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:37:32 INFO - Running post-action listener: _resource_record_post_action 11:37:32 INFO - Running post-action listener: set_extra_try_arguments 11:37:32 INFO - ##### 11:37:32 INFO - ##### Finished download-and-extract step (success) 11:37:32 INFO - ##### 11:37:32 INFO - ##### 11:37:32 INFO - ##### Running populate-webroot step. 11:37:32 INFO - ##### 11:37:32 INFO - Running pre-action listener: _resource_record_pre_action 11:37:32 INFO - Running main action method: populate_webroot 11:37:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:32 INFO - '--tppagecycles', 11:37:32 INFO - '7'], 11:37:32 INFO - 'tests': ['tsvgm']}}, 11:37:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:37:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:37:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:32 INFO - 'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:32 INFO - 'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['damp', 'tps']}, 11:37:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:32 INFO - 'tests': ['damp', 'tps']}, 11:37:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['dromaeo_dom']}, 11:37:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['a11yr', 11:37:32 INFO - 'ts_paint', 11:37:32 INFO - 'tpaint', 11:37:32 INFO - 'sessionrestore', 11:37:32 INFO - 'sessionrestore_no_auto_restore', 11:37:32 INFO - 'tabpaint']}, 11:37:32 INFO - 'other-e10s': {'tests': ['a11yr', 11:37:32 INFO - 'ts_paint', 11:37:32 INFO - 'tpaint', 11:37:32 INFO - 'sessionrestore', 11:37:32 INFO - 'sessionrestore_no_auto_restore', 11:37:32 INFO - 'tabpaint']}, 11:37:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:37:32 INFO - 'ts_paint', 11:37:32 INFO - 'tpaint', 11:37:32 INFO - 'sessionrestore', 11:37:32 INFO - 'sessionrestore_no_auto_restore', 11:37:32 INFO - 'tabpaint']}, 11:37:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:37:32 INFO - 'ts_paint', 11:37:32 INFO - 'tpaint', 11:37:32 INFO - 'sessionrestore', 11:37:32 INFO - 'sessionrestore_no_auto_restore', 11:37:32 INFO - 'tabpaint']}, 11:37:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['a11yr', 11:37:32 INFO - 'ts_paint', 11:37:32 INFO - 'tpaint', 11:37:32 INFO - 'sessionrestore', 11:37:32 INFO - 'sessionrestore_no_auto_restore', 11:37:32 INFO - 'tabpaint']}, 11:37:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['a11yr', 11:37:32 INFO - 'ts_paint', 11:37:32 INFO - 'tpaint', 11:37:32 INFO - 'sessionrestore', 11:37:32 INFO - 'sessionrestore_no_auto_restore', 11:37:32 INFO - 'tabpaint']}, 11:37:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['tsvgx', 11:37:32 INFO - 'tsvgr_opacity', 11:37:32 INFO - 'tart', 11:37:32 INFO - 'tscrollx', 11:37:32 INFO - 'cart']}, 11:37:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:37:32 INFO - 'tsvgr_opacity', 11:37:32 INFO - 'tart', 11:37:32 INFO - 'tscrollx', 11:37:32 INFO - 'cart']}, 11:37:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:32 INFO - 'talos_options': ['--disable-e10s'], 11:37:32 INFO - 'tests': ['tp5o']}, 11:37:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:32 INFO - 'tests': ['tp5o']}, 11:37:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:32 INFO - 'talos_options': ['--disable-e10s', 11:37:32 INFO - '--xperf_path', 11:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:32 INFO - 'tests': ['tp5n']}, 11:37:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:32 INFO - 'talos_options': ['--xperf_path', 11:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:32 INFO - 'tests': ['tp5n']}}, 11:37:32 INFO - 'talos.zip': {'path': '', 11:37:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:32 INFO - Running post-action listener: _resource_record_post_action 11:37:32 INFO - ##### 11:37:32 INFO - ##### Finished populate-webroot step (success) 11:37:32 INFO - ##### 11:37:32 INFO - ##### 11:37:32 INFO - ##### Running create-virtualenv step. 11:37:32 INFO - ##### 11:37:32 INFO - Running pre-action listener: _resource_record_pre_action 11:37:32 INFO - Running main action method: create_virtualenv 11:37:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:32 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 11:37:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:37:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:32 INFO - Using real prefix '/usr' 11:37:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:35 INFO - Installing pip.................done. 11:37:35 INFO - Return code: 0 11:37:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:35 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 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37:35 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 11:37:35 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 11:37:35 INFO - Using env: {'DISPLAY': ':0', 11:37:35 INFO - 'HOME': '/home/cltbld', 11:37:35 INFO - 'LANG': 'en_US.UTF-8', 11:37:35 INFO - 'LANGUAGE': 'en_US:en', 11:37:35 INFO - 'LOGNAME': 'cltbld', 11:37:35 INFO - 'MAIL': '/var/mail/cltbld', 11:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:35 INFO - 'MOZ_NO_REMOTE': '1', 11:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:35 INFO - 'NO_EM_RESTART': '1', 11:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:35 INFO - 'PWD': '/builds/slave/test', 11:37:35 INFO - 'SHELL': '/bin/bash', 11:37:35 INFO - 'SHLVL': '1', 11:37:35 INFO - 'TERM': 'linux', 11:37:35 INFO - 'TMOUT': '86400', 11:37:35 INFO - 'USER': 'cltbld', 11:37:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:35 INFO - '_': '/tools/buildbot/bin/python'} 11:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:35 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 11:37:35 INFO - Cleaning up... 11:37:35 INFO - Return code: 0 11:37:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:35 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 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37:35 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 11:37:35 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 11:37:35 INFO - Using env: {'DISPLAY': ':0', 11:37:35 INFO - 'HOME': '/home/cltbld', 11:37:35 INFO - 'LANG': 'en_US.UTF-8', 11:37:35 INFO - 'LANGUAGE': 'en_US:en', 11:37:35 INFO - 'LOGNAME': 'cltbld', 11:37:35 INFO - 'MAIL': '/var/mail/cltbld', 11:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:35 INFO - 'MOZ_NO_REMOTE': '1', 11:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:35 INFO - 'NO_EM_RESTART': '1', 11:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:35 INFO - 'PWD': '/builds/slave/test', 11:37:35 INFO - 'SHELL': '/bin/bash', 11:37:35 INFO - 'SHLVL': '1', 11:37:35 INFO - 'TERM': 'linux', 11:37:35 INFO - 'TMOUT': '86400', 11:37:35 INFO - 'USER': 'cltbld', 11:37:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:35 INFO - '_': '/tools/buildbot/bin/python'} 11:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:35 INFO - Downloading/unpacking psutil>=3.1.1 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:35 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 11:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:37 INFO - Installing collected packages: psutil 11:37:37 INFO - Running setup.py install for psutil 11:37:37 INFO - building 'psutil._psutil_linux' extension 11:37:37 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 11:37:37 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 11:37:37 INFO - building 'psutil._psutil_posix' extension 11:37:37 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 11:37:37 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 11:37:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:37 INFO - Successfully installed psutil 11:37:37 INFO - Cleaning up... 11:37:38 INFO - Return code: 0 11:37:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:37: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 mozsystemmonitor==0.3 11:37:38 INFO - Using env: {'DISPLAY': ':0', 11:37:38 INFO - 'HOME': '/home/cltbld', 11:37:38 INFO - 'LANG': 'en_US.UTF-8', 11:37:38 INFO - 'LANGUAGE': 'en_US:en', 11:37:38 INFO - 'LOGNAME': 'cltbld', 11:37:38 INFO - 'MAIL': '/var/mail/cltbld', 11:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:38 INFO - 'MOZ_NO_REMOTE': '1', 11:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:38 INFO - 'NO_EM_RESTART': '1', 11:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:38 INFO - 'PWD': '/builds/slave/test', 11:37:38 INFO - 'SHELL': '/bin/bash', 11:37:38 INFO - 'SHLVL': '1', 11:37:38 INFO - 'TERM': 'linux', 11:37:38 INFO - 'TMOUT': '86400', 11:37:38 INFO - 'USER': 'cltbld', 11:37:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:38 INFO - '_': '/tools/buildbot/bin/python'} 11:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:37:40 INFO - Installing collected packages: mozsystemmonitor 11:37:40 INFO - Running setup.py install for mozsystemmonitor 11:37:40 INFO - Successfully installed mozsystemmonitor 11:37:40 INFO - Cleaning up... 11:37:40 INFO - Return code: 0 11:37:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:40 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 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37:40 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 11:37:40 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 11:37:40 INFO - Using env: {'DISPLAY': ':0', 11:37:40 INFO - 'HOME': '/home/cltbld', 11:37:40 INFO - 'LANG': 'en_US.UTF-8', 11:37:40 INFO - 'LANGUAGE': 'en_US:en', 11:37:40 INFO - 'LOGNAME': 'cltbld', 11:37:40 INFO - 'MAIL': '/var/mail/cltbld', 11:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:40 INFO - 'MOZ_NO_REMOTE': '1', 11:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:40 INFO - 'NO_EM_RESTART': '1', 11:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:40 INFO - 'PWD': '/builds/slave/test', 11:37:40 INFO - 'SHELL': '/bin/bash', 11:37:40 INFO - 'SHLVL': '1', 11:37:40 INFO - 'TERM': 'linux', 11:37:40 INFO - 'TMOUT': '86400', 11:37:40 INFO - 'USER': 'cltbld', 11:37:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:40 INFO - '_': '/tools/buildbot/bin/python'} 11:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:40 INFO - Downloading/unpacking blobuploader==1.2.4 11:37:40 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 11:37:40 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 11:37:40 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 11:37:40 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 11:37:40 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 11:37:40 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 11:37:42 INFO - Downloading blobuploader-1.2.4.tar.gz 11:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:37:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:37:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:42 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 11:37:43 INFO - Downloading docopt-0.6.1.tar.gz 11:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:37:43 INFO - Installing collected packages: blobuploader, requests, docopt 11:37:43 INFO - Running setup.py install for blobuploader 11:37:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:37:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:37:43 INFO - Running setup.py install for requests 11:37:43 INFO - Running setup.py install for docopt 11:37:43 INFO - Successfully installed blobuploader requests docopt 11:37:43 INFO - Cleaning up... 11:37:43 INFO - Return code: 0 11:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:43 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 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37:43 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 11:37:43 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 11:37:43 INFO - Using env: {'DISPLAY': ':0', 11:37:43 INFO - 'HOME': '/home/cltbld', 11:37:43 INFO - 'LANG': 'en_US.UTF-8', 11:37:43 INFO - 'LANGUAGE': 'en_US:en', 11:37:43 INFO - 'LOGNAME': 'cltbld', 11:37:43 INFO - 'MAIL': '/var/mail/cltbld', 11:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:43 INFO - 'MOZ_NO_REMOTE': '1', 11:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:43 INFO - 'NO_EM_RESTART': '1', 11:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:43 INFO - 'PWD': '/builds/slave/test', 11:37:43 INFO - 'SHELL': '/bin/bash', 11:37:43 INFO - 'SHLVL': '1', 11:37:43 INFO - 'TERM': 'linux', 11:37:43 INFO - 'TMOUT': '86400', 11:37:43 INFO - 'USER': 'cltbld', 11:37:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:43 INFO - '_': '/tools/buildbot/bin/python'} 11:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:44 INFO - Running setup.py (path:/tmp/pip-Ug73nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:44 INFO - Running setup.py (path:/tmp/pip-BrJFcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:44 INFO - Running setup.py (path:/tmp/pip-U0x4oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:44 INFO - Running setup.py (path:/tmp/pip-4yyeEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:44 INFO - Running setup.py (path:/tmp/pip-0wuJzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:44 INFO - Running setup.py (path:/tmp/pip-lW1Z2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:44 INFO - Running setup.py (path:/tmp/pip-N0Qcs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:44 INFO - Running setup.py (path:/tmp/pip-1x1dqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:44 INFO - Running setup.py (path:/tmp/pip-OKBYSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:44 INFO - Running setup.py (path:/tmp/pip-mcnRlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:44 INFO - Running setup.py (path:/tmp/pip-ltpH8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:44 INFO - Running setup.py (path:/tmp/pip-EynFFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:44 INFO - Running setup.py (path:/tmp/pip-AGbR91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:44 INFO - Running setup.py (path:/tmp/pip-MJuHJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:45 INFO - Running setup.py (path:/tmp/pip-twTQo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:45 INFO - Running setup.py (path:/tmp/pip-2ZF4NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:45 INFO - Running setup.py (path:/tmp/pip-DlhgH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:37:45 INFO - Running setup.py install for manifestparser 11:37:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:37:45 INFO - Running setup.py install for mozcrash 11:37:45 INFO - Running setup.py install for mozdebug 11:37:45 INFO - Running setup.py install for mozdevice 11:37:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:37:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:37:45 INFO - Running setup.py install for mozfile 11:37:45 INFO - Running setup.py install for mozhttpd 11:37:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:37:45 INFO - Running setup.py install for mozinfo 11:37:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:37:45 INFO - Running setup.py install for mozInstall 11:37:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Running setup.py install for mozleak 11:37:46 INFO - Running setup.py install for mozlog 11:37:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Running setup.py install for moznetwork 11:37:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Running setup.py install for mozprocess 11:37:46 INFO - Running setup.py install for mozprofile 11:37:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Running setup.py install for mozrunner 11:37:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Running setup.py install for mozscreenshot 11:37:46 INFO - Running setup.py install for moztest 11:37:46 INFO - Running setup.py install for mozversion 11:37:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:37:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:37:47 INFO - Cleaning up... 11:37:47 INFO - Return code: 0 11:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:47 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 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37:47 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 11:37:47 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 11:37:47 INFO - Using env: {'DISPLAY': ':0', 11:37:47 INFO - 'HOME': '/home/cltbld', 11:37:47 INFO - 'LANG': 'en_US.UTF-8', 11:37:47 INFO - 'LANGUAGE': 'en_US:en', 11:37:47 INFO - 'LOGNAME': 'cltbld', 11:37:47 INFO - 'MAIL': '/var/mail/cltbld', 11:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:47 INFO - 'MOZ_NO_REMOTE': '1', 11:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:47 INFO - 'NO_EM_RESTART': '1', 11:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:47 INFO - 'PWD': '/builds/slave/test', 11:37:47 INFO - 'SHELL': '/bin/bash', 11:37:47 INFO - 'SHLVL': '1', 11:37:47 INFO - 'TERM': 'linux', 11:37:47 INFO - 'TMOUT': '86400', 11:37:47 INFO - 'USER': 'cltbld', 11:37:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:47 INFO - '_': '/tools/buildbot/bin/python'} 11:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:47 INFO - Running setup.py (path:/tmp/pip-zNT6DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:47 INFO - Running setup.py (path:/tmp/pip-UiHG5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:47 INFO - Running setup.py (path:/tmp/pip-1hq61E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:47 INFO - Running setup.py (path:/tmp/pip-KDIcgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:47 INFO - Running setup.py (path:/tmp/pip-Kiezbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:47 INFO - Running setup.py (path:/tmp/pip-J1wO59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:47 INFO - Running setup.py (path:/tmp/pip-k4Mcwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:47 INFO - Running setup.py (path:/tmp/pip-4XjmcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:47 INFO - Running setup.py (path:/tmp/pip-RqewKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:47 INFO - Running setup.py (path:/tmp/pip-iEKAJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:47 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)) 11:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:47 INFO - Running setup.py (path:/tmp/pip-A5VZ8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:48 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)) 11:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:48 INFO - Running setup.py (path:/tmp/pip-qg5VAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:48 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)) 11:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:48 INFO - Running setup.py (path:/tmp/pip-UbMFYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:48 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)) 11:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:48 INFO - Running setup.py (path:/tmp/pip-uDPg2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:48 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)) 11:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:48 INFO - Running setup.py (path:/tmp/pip-TjwvrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:48 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)) 11:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:48 INFO - Running setup.py (path:/tmp/pip-cH2pPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:48 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)) 11:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:48 INFO - Running setup.py (path:/tmp/pip-yjfH18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:37:48 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 11:37:48 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 11:37:48 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 11:37:48 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 11:37:48 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 11:37:48 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 11:37:50 INFO - Downloading blessings-1.6.tar.gz 11:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:37:50 INFO - Installing collected packages: blessings 11:37:50 INFO - Running setup.py install for blessings 11:37:50 INFO - Successfully installed blessings 11:37:50 INFO - Cleaning up... 11:37:50 INFO - Return code: 0 11:37:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:37:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:50 INFO - Reading from file tmpfile_stdout 11:37:50 INFO - Current package versions: 11:37:50 INFO - argparse == 1.2.1 11:37:50 INFO - blessings == 1.6 11:37:50 INFO - blobuploader == 1.2.4 11:37:50 INFO - docopt == 0.6.1 11:37:50 INFO - manifestparser == 1.1 11:37:50 INFO - mozInstall == 1.12 11:37:50 INFO - mozcrash == 0.17 11:37:50 INFO - mozdebug == 0.1 11:37:50 INFO - mozdevice == 0.48 11:37:50 INFO - mozfile == 1.2 11:37:50 INFO - mozhttpd == 0.7 11:37:50 INFO - mozinfo == 0.9 11:37:50 INFO - mozleak == 0.1 11:37:50 INFO - mozlog == 3.2 11:37:50 INFO - moznetwork == 0.27 11:37:50 INFO - mozprocess == 0.22 11:37:50 INFO - mozprofile == 0.28 11:37:50 INFO - mozrunner == 6.11 11:37:50 INFO - mozscreenshot == 0.1 11:37:50 INFO - mozsystemmonitor == 0.3 11:37:50 INFO - moztest == 0.7 11:37:50 INFO - mozversion == 1.4 11:37:50 INFO - psutil == 3.1.1 11:37:50 INFO - requests == 1.2.3 11:37:50 INFO - wsgiref == 0.1.2 11:37:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:50 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 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37:50 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 11:37:50 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 11:37:50 INFO - Using env: {'DISPLAY': ':0', 11:37:50 INFO - 'HOME': '/home/cltbld', 11:37:50 INFO - 'LANG': 'en_US.UTF-8', 11:37:50 INFO - 'LANGUAGE': 'en_US:en', 11:37:50 INFO - 'LOGNAME': 'cltbld', 11:37:50 INFO - 'MAIL': '/var/mail/cltbld', 11:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:50 INFO - 'MOZ_NO_REMOTE': '1', 11:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:50 INFO - 'NO_EM_RESTART': '1', 11:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:50 INFO - 'PWD': '/builds/slave/test', 11:37:50 INFO - 'SHELL': '/bin/bash', 11:37:50 INFO - 'SHLVL': '1', 11:37:50 INFO - 'TERM': 'linux', 11:37:50 INFO - 'TMOUT': '86400', 11:37:50 INFO - 'USER': 'cltbld', 11:37:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:50 INFO - '_': '/tools/buildbot/bin/python'} 11:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 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)) 11:37:50 INFO - Cleaning up... 11:37:51 INFO - Return code: 0 11:37:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:37:51 INFO - Using env: {'DISPLAY': ':0', 11:37:51 INFO - 'HOME': '/home/cltbld', 11:37:51 INFO - 'LANG': 'en_US.UTF-8', 11:37:51 INFO - 'LANGUAGE': 'en_US:en', 11:37:51 INFO - 'LOGNAME': 'cltbld', 11:37:51 INFO - 'MAIL': '/var/mail/cltbld', 11:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:51 INFO - 'MOZ_NO_REMOTE': '1', 11:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:51 INFO - 'NO_EM_RESTART': '1', 11:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:51 INFO - 'PWD': '/builds/slave/test', 11:37:51 INFO - 'SHELL': '/bin/bash', 11:37:51 INFO - 'SHLVL': '1', 11:37:51 INFO - 'TERM': 'linux', 11:37:51 INFO - 'TMOUT': '86400', 11:37:51 INFO - 'USER': 'cltbld', 11:37:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:51 INFO - '_': '/tools/buildbot/bin/python'} 11:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:51 INFO - Downloading/unpacking jsonschema 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:37:53 INFO - Downloading/unpacking functools32 (from jsonschema) 11:37:53 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 11:37:53 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 11:37:53 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 11:37:53 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 11:37:53 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 11:37:53 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 11:37:53 INFO - Downloading functools32-3.2.3-2.tar.gz 11:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:37:53 INFO - warning: no files found matching '*.txt' 11:37:53 INFO - no previously-included directories found matching 'build' 11:37:53 INFO - no previously-included directories found matching 'dist' 11:37:53 INFO - no previously-included directories found matching '.git*' 11:37:53 INFO - Installing collected packages: jsonschema, functools32 11:37:53 INFO - Running setup.py install for functools32 11:37:53 INFO - warning: no files found matching '*.txt' 11:37:53 INFO - no previously-included directories found matching 'build' 11:37:53 INFO - no previously-included directories found matching 'dist' 11:37:53 INFO - no previously-included directories found matching '.git*' 11:37:53 INFO - Successfully installed jsonschema functools32 11:37:53 INFO - Cleaning up... 11:37:53 INFO - Return code: 0 11:37:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f034ad73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1009770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', '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 11:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:37:53 INFO - Using env: {'DISPLAY': ':0', 11:37:53 INFO - 'HOME': '/home/cltbld', 11:37:53 INFO - 'LANG': 'en_US.UTF-8', 11:37:53 INFO - 'LANGUAGE': 'en_US:en', 11:37:53 INFO - 'LOGNAME': 'cltbld', 11:37:53 INFO - 'MAIL': '/var/mail/cltbld', 11:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:53 INFO - 'MOZ_NO_REMOTE': '1', 11:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:53 INFO - 'NO_EM_RESTART': '1', 11:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:53 INFO - 'PWD': '/builds/slave/test', 11:37:53 INFO - 'SHELL': '/bin/bash', 11:37:53 INFO - 'SHLVL': '1', 11:37:53 INFO - 'TERM': 'linux', 11:37:53 INFO - 'TMOUT': '86400', 11:37:53 INFO - 'USER': 'cltbld', 11:37:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:53 INFO - '_': '/tools/buildbot/bin/python'} 11:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:53 INFO - Downloading/unpacking flake8 11:37:53 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 11:37:53 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 11:37:53 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 11:37:53 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 11:37:53 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 11:37:53 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 11:37:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:37:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:37:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:37:56 INFO - no previously-included directories found matching 'docs/_build' 11:37:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:37:56 INFO - Running setup.py install for pep8 11:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:37:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:37:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:37:56 INFO - no previously-included directories found matching 'docs/_build' 11:37:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:37:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:37:56 INFO - Cleaning up... 11:37:56 INFO - Return code: 0 11:37:56 INFO - Running post-action listener: _resource_record_post_action 11:37:56 INFO - Running post-action listener: _start_resource_monitoring 11:37:56 INFO - Starting resource monitoring. 11:37:56 INFO - ##### 11:37:56 INFO - ##### Finished create-virtualenv step (success) 11:37:56 INFO - ##### 11:37:56 INFO - ##### 11:37:56 INFO - ##### Running install step. 11:37:56 INFO - ##### 11:37:56 INFO - Running pre-action listener: _resource_record_pre_action 11:37:56 INFO - Running main action method: install 11:37:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:57 INFO - Reading from file tmpfile_stdout 11:37:57 INFO - Detecting whether we're running mozinstall >=1.0... 11:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:37:57 INFO - Reading from file tmpfile_stdout 11:37:57 INFO - Output received: 11:37:57 INFO - Usage: mozinstall [options] installer 11:37:57 INFO - Options: 11:37:57 INFO - -h, --help show this help message and exit 11:37:57 INFO - -d DEST, --destination=DEST 11:37:57 INFO - Directory to install application into. [default: 11:37:57 INFO - "/builds/slave/test"] 11:37:57 INFO - --app=APP Application being installed. [default: firefox] 11:37:57 INFO - mkdir: /builds/slave/test/build/application 11:37:57 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'] 11:37:57 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 11:38:12 INFO - Reading from file tmpfile_stdout 11:38:12 INFO - Output received: 11:38:12 INFO - /builds/slave/test/build/application/firefox/firefox 11:38:12 INFO - Running post-action listener: _resource_record_post_action 11:38:12 INFO - ##### 11:38:12 INFO - ##### Finished install step (success) 11:38:12 INFO - ##### 11:38:12 INFO - ##### 11:38:12 INFO - ##### Running run-tests step. 11:38:12 INFO - ##### 11:38:12 INFO - Running pre-action listener: _resource_record_pre_action 11:38:12 INFO - Running main action method: run_tests 11:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:38:12 INFO - Python 2.7.3 11:38:12 INFO - Return code: 0 11:38:12 INFO - grabbing minidump binary from tooltool 11:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:38:12 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 0x10989c0>, '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 0x10998c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:38:12 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 11:38:12 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 11:38:12 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 11:38:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:38:13 INFO - Return code: 0 11:38:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:38:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:38:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:38:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:38:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:38:13 INFO - Return code: 0 11:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:38:13 INFO - Using env: {'DISPLAY': ':0', 11:38:13 INFO - 'HOME': '/home/cltbld', 11:38:13 INFO - 'LANG': 'en_US.UTF-8', 11:38:13 INFO - 'LANGUAGE': 'en_US:en', 11:38:13 INFO - 'LOGNAME': 'cltbld', 11:38:13 INFO - 'MAIL': '/var/mail/cltbld', 11:38:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:38:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:13 INFO - 'MOZ_NO_REMOTE': '1', 11:38:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:13 INFO - 'NO_EM_RESTART': '1', 11:38:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:13 INFO - 'PWD': '/builds/slave/test', 11:38:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:38:13 INFO - 'SHELL': '/bin/bash', 11:38:13 INFO - 'SHLVL': '1', 11:38:13 INFO - 'TERM': 'linux', 11:38:13 INFO - 'TMOUT': '86400', 11:38:13 INFO - 'USER': 'cltbld', 11:38:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018', 11:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:13 INFO - '_': '/tools/buildbot/bin/python'} 11:38:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:38:14 INFO - mozversion application_buildid: 20160523105048 11:38:14 INFO - mozversion application_changeset: 60435b82caee3a0c05466ff2249a574df57214e6 11:38:14 INFO - mozversion application_display_name: Nightly 11:38:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:38:14 INFO - mozversion application_name: Firefox 11:38:14 INFO - mozversion application_remotingname: firefox 11:38:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:38:14 INFO - mozversion application_vendor: Mozilla 11:38:14 INFO - mozversion application_version: 49.0a1 11:38:14 INFO - mozversion platform_buildid: 20160523105048 11:38:14 INFO - mozversion platform_changeset: 60435b82caee3a0c05466ff2249a574df57214e6 11:38:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:38:14 INFO - mozversion platform_version: 49.0a1 11:38:14 INFO - using testdate: 1464028694 11:38:14 INFO - actual date: 1464028694 11:38:14 INFO - starting webserver on 'localhost:55537' 11:38:14 INFO - SUITE-START | Running 2 tests 11:38:14 INFO - TEST-START | dromaeo_css 11:38:14 INFO - operating with platform_type : linux_ 11:38:14 INFO - Initialising browser for dromaeo_css test... 11:38:14 INFO - TEST-INFO | started process 3321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHUCZcL/profile http://localhost:55537/getInfo.html) 11:38:18 INFO - PROCESS | 3321 | __metrics Screen width/height:1600/1200 11:38:18 INFO - PROCESS | 3321 | colorDepth:24 11:38:18 INFO - PROCESS | 3321 | Browser inner width/height: 1024/697 11:38:18 INFO - PROCESS | 3321 | __metrics 11:38:19 ERROR - PROCESS | 3321 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:38:20 INFO - TEST-INFO | 3321: exit 0 11:38:20 INFO - Browser initialized. 11:38:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:38:20 INFO - TEST-INFO | started process 3401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHUCZcL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:32 INFO - PROCESS | 3401 | RSS: Main: 155324416 11:38:32 INFO - PROCESS | 3401 | 11:39:24 INFO - PROCESS | 3401 | 1464028764312 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] 11:41:36 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55537/tests/dromaeo/cssquery-ext.html) 11:41:37 INFO - PROCESS | 3401 | RSS: Main: 237350912 11:41:37 INFO - PROCESS | 3401 | 11:44:39 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-ext.html (next: http://localhost:55537/tests/dromaeo/cssquery-jquery.html) 11:44:40 INFO - PROCESS | 3401 | RSS: Main: 240201728 11:44:40 INFO - PROCESS | 3401 | 11:47:42 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55537/tests/dromaeo/cssquery-mootools.html) 11:47:43 INFO - PROCESS | 3401 | RSS: Main: 241770496 11:47:43 INFO - PROCESS | 3401 | 11:50:45 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55537/tests/dromaeo/cssquery-prototype.html) 11:50:45 INFO - PROCESS | 3401 | RSS: Main: 242384896 11:50:45 INFO - PROCESS | 3401 | 11:53:48 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55537/tests/dromaeo/cssquery-yui.html) 11:53:49 INFO - PROCESS | 3401 | RSS: Main: 220475392 11:53:49 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-yui.html (next: http://localhost:55537/tests/dromaeo/cssquery-dojo.html) 11:56:52 INFO - PROCESS | 3401 | RSS: Main: 275812352 11:56:52 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | __start_tp_report 11:56:52 INFO - PROCESS | 3401 | _x_x_mozilla_page_load 11:56:52 INFO - PROCESS | 3401 | _x_x_mozilla_page_load_details 11:56:52 INFO - PROCESS | 3401 | |i|pagename|runs| 11:56:52 INFO - PROCESS | 3401 | |0;dojo.html;2653.0714250012497;2676.8393896366206;2704.7160048194937;2705.8782354794034;2717.9864100679492;4608;4637.6289896808175;4671.4627817800965;4716.056788642268;4738.881527961803;4711.9162592603725;4717.834875779348;4719.622430205584;4792.496787837279;4796;4132.628063474287;4302.913941721155;4388.100439409914;4415.183191109639;4491.573300536444;4396.1427521633295;4422.7125236859665;4447.332900065;4447.35513350564;4484.573965473275;4306.2248795217;4315.892102697458;4328.956710432887;4342.804573794187;4359.455068116486;4342.826286948518;4346.239408103601;4348.608625223745;4394.868153955386;4402.119576084796;4345.348197770328;4362.040351122748;4368.650507959355;4401.559844015573;4401.669874759374;4567.1779079765965;4633.119707255611;4696.81212751493;4711.03423798124;4718.528147185254;5127.0258650856595;5160.664556803796;5181.248718935771;5186.662866913676;5186.688798672054;5170.741462926876;5176.663516871391;5185.066687996159;5189.143791274435;5191.117510023268;4622.052479241747;4743.810247590127;4797.064572408417;4798.568128868418;4864.489228630943;5256.789728410898;5321.122014867581;5321.680699158062;5322.654027488201;5330.546903513245;4832.734199619054;5041.647084704109;5050.444451110375;5051.87370315745;5054.444011158769;5081.161608334657;5119.846404607868;5137.717425541631;5142.485751424828;5159.045576568272;5110.718910459886;5115.462876397924;5116.846494605168;5119.795208191705;5138.434772175057;4942.5304596063315;4976.601871850244;5098.107831129538;5101.438841727407;5115.18157094863;4260.190563792869;4270.551592082787;4272.829086836554;4274.10243848789;4283.87148385549;3774.5659249186147;3808.21931504041;3818.3508803503473;3820.656140947328;3823.158905040942;4419.0940857124215;4420.248557745191;4429.49060857999;4455.465344158657;4479.888002799956;5191.714455704972;5196.428392876781;5201.3238279024245;5203.947960520422;5240.135377662719;4458.7324760514475;4461.063176732858;4462.464504259445;4493.0789188216995;4511.255642818964;4438.4451943507065;4507.797149128297;4524.140413321458;4541.886452838706;4548.522405147478;4820.493848145964;4820.807167713322;4822.13201623697;4829.348038014823;4839.516048395132;5089.491050894881;5093.8726531837;5094.15946368845;5099.6175286852895;5148.4851514848215;4690;4812.205986012269;4856.223004319292;4878.414590249193;4881.731504767272;5049.040682270357;5068.417132029864;5071.18860982241;5084.745762711924;5127.974360128175;4925.433575138762;5101.821436249714;5113.360829896263;5117.2068329409;5123.23151527259;4874.53691899269;4888.780004899859;4929.186684197068;4946.109700253989;5002.399712034579;4935.851924442272;4941;4947;4948.925766113583;4991;4712.69367491112;4868.17241069012;4876.390451193601;4878.317035614946;4921.753912304442;4960;4991.126552853164;5015.322931404214;5017.197248440232;5022.3219865317715;4907.092187945242;4907.337509436323;4909.607231421406;4911.066897289504;4958.206686930218 11:56:52 INFO - PROCESS | 3401 | |1;ext.html;555.253184466892;567.248395875465;588.5615216663581;593.9821805345838;595.6217801695924;40166.39750403743;42192.156156876845;42242.366364504516;44911.77544112283;44988.77505612475;41965.37051944216;42615.78692106535;42644.57355426445;42726.35910461338;42747;7613.124490683587;7642.808929776745;7859.68561257549;7860.056793184797;9797.706068817946;9636.61453541861;10039.397636141855;10063;10068.74828129299;10075.546600402999;10042;10046;10126.088652021317;10126.746831329203;10134.391936483798;7510.286522780327;9859.802803943881;9990.300678952477;10157.644482443078;10177;9980.850287245697;10070.496475176213;10071.395716257048;10076.647317343932;10094.141997930185;39187.412188817194;39428.40857387141;39567.60432395668;39628.40557391642;39659.40510892339;3123.1723593247807;3189.1548739584027;3220.806751594912;3487.6512348764923;3852.0755018795567;30029.24926876824;30117.69882301171;30451.69548304533;30599.541006884916;30949.22626934322;3562.0738607961857;3575.7496975211748;3588.946165807515;3593.4250519916686;3612.801295928723;185275;186004.06997965058;186700;186956;187134;32271.51592726111;55472.445275547536;55564.444355556734;55996.72001639966;55999.720001399735;32783.83608081944;34714.65285347165;34724.47913281303;34748.82625586856;34782;11054.447277636247;11173.273737207055;11175.161862860317;11185.440727963569;11188.776224475465;7521.736739214101;8094.757157285291;8103.3112185463715;8153.429259951747;8268.875966860502;7914.643841027168;7921.881171782428;7956.761297161094;7994.960025199953;8027.839443211103;3087.1664650544226;3096.442640324718;3102.5811515445125;3132.4048430798075;3151.558781770554;926.5737760630051;933.9859902101474;936.9063093690577;954.6801821389912;996.0537489385113;27769.722302776714;28422;28565.57499925044;29096.854515727286;29232.853835730686;964.8855571814565;978.7602037500858;983.2772911909741;988.3773222869546;1019.6635110413546;15048.548543543711;15520;15594;15654.295556699975;15754.054756714633;377553;380812;383258;383313;383465;50195.49804501981;50709;50731.49268507268;50780.746096269286;50995.23507147396;1106;1185.4791269928298;1197.4910662968205;1204.3195594489086;1221.419825582841;28494.287642808267;29230;29338.559921600765;29589.704102958694;30064.24839379033;41947.1610567793;42504.57495425006;42566.78716606397;42641;42741;299621;304626;306486;307662;309211;22413.21553745611;22645;22992;23640;27278.181654550393;42380;42402.36396453994;42802.57197427986;43194;43403.78298108489;35328.88026718405;36204;37075.25849482941;37118;37283;36477.81761091178;36492.81753591215;36814.44778328381;37221.441678375384;37669;34756.47865282073;35068.64931350654;35553.82223088868;35684.107897302776;35849.283014339046;32173.839130804197;32909.31432295416;33246;33347.166320842174;33529.49705754464;25131;25366.492670146126;25535.23394298174;25669.871650641628;25826.096086636877 11:56:52 INFO - PROCESS | 3401 | |2;jquery.html;367.2178260305548;374.2813797508783;375.1877185892543;380.1408816075668;385.74155315938316;16407.425740099097;16924.915375423105;17155.228014739336;17319.91340043301;17532.56168595784;16199.190040497957;16553;17190.312387504484;17198.484045478624;17222.13889305533;5064.442911279765;5233.267342572043;5248.501392367719;5296.311479507659;5306.469353064682;3778.7165962552917;3875.670568001709;3944.7830369329677;5160.406553246368;6077.969610151965;6013.067974463965;6140.570160088796;6176.444120029197;6181.598196117238;6183.845403864894;5787.594868359217;6117.021276595746;6127.325994140641;6137.631742095444;6141.385861413867;3399.1332210286464;5022.17134172861;5325.201219817059;5393.973030134864;5406;20075.598488030304;20539.5892082159;20576.176952921865;20826.47933801652;20847.478813029644;1915.9137838797287;1964.9607007859763;1980.366282789508;2005.0776642744356;2136.83973701973;12886.87113128866;12903.935480322538;13162;13243.337833108402;13293.335333233397;1723.2503860820584;1736.1492868494347;1744.9912750436167;1773.1488885335111;1841.4475657302755;42874.785626071985;43694.49733387308;58124.41875581232;59277.40722592762;68537.3146268536;9867.605295788231;10074.496275186211;10293.43386113771;10297.227707921937;10867.78264434707;14057.226852523005;14132.646683832781;14134.717305653829;14134.929325353307;14187.574372768833;6464.159659244268;6609.735610575523;6649.767258145942;6759.898601520981;6801.65991700413;5997.820065398045;6068.4538391544975;6145.907811382833;6169.105479705418;6186.381361863778;6239.906401403982;6300.9684951574945;6301.905471417932;6345.206849143857;6370.394812492806;1766.4788887278285;1829.4054432309554;1841.1714728372285;1853.5829438376256;1858.6189831084596;882.3823323673454;886.1050339157497;887.0863011098579;889.0842432294746;931.9301052421096;16521.256543455573;16594.170291485378;17014.659706806044;17653.20560574777;17857.732134018;903.4669544968368;904.2404380320562;912.7581190984395;932.4871320773683;952.9618815247312;7787.92212077872;9846.753831154278;9917.256205784595;10038.548265328078;10123.03831136041;401519;405100;415517;421716;423204;76905;83656.58171709103;83757.58121209354;84189.57905210435;85003.57498212592;750.6884642873256;912.9132732390412;940.1209868772582;960.5389413081759;969.6509256667593;15519.76720349173;15878.412158784491;15962.361505539648;16258.837411625733;16282.837171628606;33628.831855840566;33652.831735841166;33825.661743383236;35280;35349;46476.76761616306;47713.52286477091;50094;50379.24431133462;50501.242481363544;7523.699052038076;7524.5861477619255;7600.695972161052;7684.346830519468;7781.883271751041;8453.788655283666;10972.341659500455;11153.553857845594;11361.602343917923;11378.601748938747;9425.05749425052;9590.66432674853;9841.852372214566;10012.949935250277;10324.638637647646;9614.615415383587;9967.551460184453;10064.597416103567;10127.64553240633;10246.180305575685;7985.321247694011;8176.305014073871;8797.428167169113;9715.70852874415;9792.706218813448;7552.244775522404;7698.422618303538;7768.84462310762;7776.7278145264645;7977.2022797719765;9655.662051828152;9809.362391444532;9935.751606209902;9939.602415903282;10151.086402223835 11:56:52 INFO - PROCESS | 3401 | |3;mootools.html;1312.573413640567;1415.801787749715;1459.5475402625184;1571.6228105254743;1769.955751106223;6715.127033485646;7667.846643067135;7908.92091079089;7916.445848790587;8113.43205975582;7795.844083118334;7939.5633240171765;7952.165022672622;7954.92045079549;7956.045274567045;1840.6778813707615;2109.4199095248778;2162.5782972320403;2203.10774136475;2204.6362350212194;2193.396815875639;2215.9224427144973;2216.7007453993747;2218.8557743746687;2227.7326720793526;2141.15424407359;2165.307101727448;2181.4437318483765;2183.072194317409;2184.3010236724253;1776.9555761105946;2078.1791192478886;2099.6745504446835;2148.366231961575;2149.720536330267;2149.18331034206;2164.9567008659897;2170.3271985684487;2170.4573856535867;2174.826013918883;7785.688572457095;7804.492707973964;7804.72683456082;7843.803904902366;7846.372290216826;4257.893552661178;4359.738415695068;4367;4367.344898265285;4376.23415902219;2788.9302767430772;2846.217290245199;2944.1020488750924;2971.1235185620076;2981.1950773291305;939.6053657463882;948.9335746497748;949;958.1759686669459;958.4441024206013;10824.729381765519;10836.187285953585;10858.837117443245;10860.076893464066;10865.51105200268;4173.10278290169;4173.582641735802;4275.87172384829;4285.8285668573535;4287.5926786955815;9196.494192819326;9274.675386361445;9276.582553785096;9278.62885484573;9295.860562091573;4319.071399649028;4369.737815731066;4403.119376124788;4408.735475871458;4412.4705035395955;3394.0496660934978;3802.9429558556644;3940.7241493095207;3962.306596345628;3979.8408063677707;3539.309834582232;3608.2061946371755;3635.2184280379847;3664.5052917856283;3687.2441149564274;1194.4386138514883;1196.2045239915358;1213.805791073424;1222.443788076423;1222.5598784437595;664.7473959895209;752.7440670172168;754.7773406844993;801.0107517216234;848.0332421039896;4821.855344339676;4885.828995985124;4895.31465594817;4901.730404827768;5034.748262586856;856.2850020233175;860.9956950215209;868.2418103340785;869.2437579305918;872.7992561710842;3260.103471545344;3326.5010248462922;3356.0938546592283;3376.679215474526;3439.604445488801;9602.807943841084;9791.853122203172;9924.1068303853;9953.80092398148;9974.002599739968;9764.560594773111;9848.06443387877;9872;9876.65431709901;9883.950580247196;7396.852062958711;7397.667104980181;7523.172451030382;7552.169261381244;7560.319571238615;4979.128652485873;4996.3005179274205;5007.37407824022;5073.847784566469;5110.029094472038;9073.818523629623;9090.727278181665;9110.453372797654;9125.817483650422;9205.355625106178;8761.123887611187;9123.406978546373;9136.132067453582;9451.574679139318;9451.763705907408;6153.107799369156;6293.496520278458;6410.358964103552;6500.7399704013205;6649.667516624053;7667.463277570517;7696;7753.883691744515;7765.378769698524;7774.766756997299;6859.416949559343;6937.930620693728;6961.095057642677;6963.1296087989;7131.750388736369;6761;6778.762743303961;6783.152105986752;6898.1377327834025;6967.303269672992;6225.28409232944;6249.531285153541;6258.4680302173;6319.115323854572;6319.24169099711;4472.642188624967;4492.663050271178;4511.210538155744;4569.725816451024;4604.769761511978;4403.295472724477;4432.800523976364;4439.156560253541;4465.910681786411;4611.331356953156 11:56:52 INFO - PROCESS | 3401 | |4;prototype.html;289.82610433739745;299.1623454327882;302.3288299974058;305.977051721121;306.41780616828026;4639.721616703;4788.97605511972;4798.232282834742;4832.154372984731;4864.878378040551;4605.240135377667;4719.457262414823;4738.336632871401;4747.145513807513;4751.192297309457;3759.3045286621996;3768.3970564709653;3796.5573082228716;3800.5059342285463;3807.714421418391;3547.2018795771005;3642.362586547357;3800.771953682774;3803.2583646189005;3808.923821523582;3751.8499260029703;3756.887293381203;3789.810509474515;3796.126890815114;3804.657580817726;3747.025773298935;3754.774713517184;3766.4181043961603;3769.264993326275;3795.658390744846;3356.6978971892404;3372.6627337266077;3377.392069427502;3393.52490651309;3402.6427225141497;4473.80783416127;4579.175748365293;4580.152671755736;4581.473130589991;4584.724916504987;4282.143571285756;4287.48550173978;4309.978450107761;4310.288802347609;4316.158349121923;4795.952040479586;4889.29105279736;4914.21372580389;4963.195794376202;4996.500349965011;3552.7690700104667;3571.7141828941562;3572.2855428914063;3573.3925232710503;3576.213233088716;5213.2701421800975;5216.295800066942;5227.372715274191;5235.240890070956;5241.371035475768;3671.5227020487164;3678.1172518595345;3682.779033258013;3698.4452332149854;3698.68561172298;3554.2713743682484;3683.502727131803;3698.3712768829364;3702.8150991682405;3720.162963333228;4226.344916537942;4227.450431443954;4256.638185754246;4257.340112282601;4277.401163837066;4745.525447455227;4926.58124059459;4989.725565093882;5003.7998480061115;5007.148784706608;1228.6989687526614;1268.3594784633885;1275.7639836630253;1281.4297637551388;1284.2422970447294;802.5545822068808;818.2390376949376;820.827626198505;821.4373154389262;832.6169961817511;3987.8205480752854;3995.320795464778;3995.380715989026;4000.579939106352;4046.9392959105635;4525.343825145335;4530.369067135828;4609.608183304456;4622.422197225347;4658.720476771405;4045.3527435610163;4077.2864748668862;4081.3469844824685;4101.241270364992;4111.835526578903;2393.34183099649;2485.3538080098942;2493.4140476987895;2496.8015352630837;2497.7627125423055;4271.67962402821;4356;4375.934360984587;4389.692721509464;4415.779211039435;4659.65052621048;4666.7066299005;4668.778542805453;4672.528153631595;4682.9765851171205;4039.6970227232487;4352.455943007124;4374.693771436033;4384.2765943620225;4384.342348647729;4571.977140114278;4580.267157254823;4581.656375771897;4586.403767510203;4587.587117159472;4439.489458712289;4459.331100334846;4508.864734057984;4522.389477420637;4535.049928530763;3980.6218409251073;4335.7181783184;4373.518912919512;4394;4448;3350.765446418727;3390.6270310266345;3406.3187362527096;3412.652002458965;3413.573303337083;4522.909541809211;4530.6505754476075;4578.92395287114;4629.851700843459;4920.803167873245;4827.937853672186;4986.601071914166;5056.381957773478;5063.746812659426;5067.682402575283;5018.72022634226;5034.723090230073;5036.330744705312;5044.646874718735;5058.26655134996;4786.593139583035;4929.457759646508;4961.444855899287;4967.801287948586;4979.726115063706;5047.823326183566;5062.443131255633;5065.746712664279;5101.107306221471;5114.820981265638;4979.900401992012;4987.12725273083;4990.72551009698;5000.67495612784;5002.874928126826 11:56:52 INFO - PROCESS | 3401 | |5;yui.html;663.0617675988476;671.1208317104594;721.1886627544013;761.3642608421967;795.6697970342308;12213.572524961628;13102.14836035657;13124.803127953064;13282.402291896864;13313;12404.81392779109;12659.734026597358;12679.809802852964;12681.112322137455;12706.428210730517;637.7480895046453;802.1897883138014;802.8594995875727;821.2239433735123;828.4532208742231;818.553888130967;818.868980963046;822.8971378577678;823.423603477565;823.5388182617723;854.3250831842837;860.2129051917487;860.5009094725044;860.6729442811722;861.3841103610916;514.7297668723912;827.3422629009951;849.587949844325;851.7998270406449;853.803625166209;621.7419770795115;623.0094150301043;623.688155922039;623.7567348733998;624.09506215987;12408.503659853595;12441.191322564004;12444.502219911192;12462.937685311606;12466;11714.53141874324;12094.758104837942;12138.878611213862;12208.206466579644;12412.317322547256;9836.163926066292;9907.356021858555;10097.394156350569;10164.237682173867;11251.83122253167;4184.727992680466;4186.979065104655;4221.409002739619;4230.386593943861;4291.35629655551;46777.76611116956;46959;47009.05981880378;47015.29477057847;47220.52779472196;9792;9914.702558923243;10013.39919604826;10048.474253019696;10123.240756943258;16958.23687934046;17292.308307667805;17297.13514324304;17320.133993300286;17331;6528.08606795049;6536.803895883131;6543.476521878239;6699.263081061079;6704.59772413647;3733.197362567061;3814.8474061037805;3840.2703486337505;3847.7498962567342;3922.725409221327;2732.945341093167;2802.719728027181;2804.298925268683;2806;2806.3264816444316;494.8713334533047;498.8027737814931;501.9749012549358;502.0636512903409;512.0987062769552;548.6598309048416;555.1145922253999;573.0830670926567;579.5421616922669;583.107844997155;7792.220777922275;7893.684252629945;7906.644201010969;8010.3992200584025;8181.18188181189;448.1954890970715;493.117319997201;515.5051150895108;520.5809323494548;527.6438404077232;3541.3448512025357;3612.6026137124895;3615.313090512794;3636.07280143567;3736.4582135590185;55124.72437637786;55762;56877;57174.142387864216;57519;49918;51324;51432.485675143515;52265;52624.73687631537;46465.53534464612;46827;47607.76196119066;47715;48031.27953080706;7272.854542909006;7358.11702595692;7386.372158366599;7457.925420745723;7475.925240747741;31646.683533165295;32015.35969280555;32156.83921580377;32190.67809321877;32763.34473310568;38572.2285554293;40636.59363406328;41353.379699303936;41970;42044.78977605092;9207.631694732136;9310.162085412345;9315.580798863932;9345.0654934506;9378.343515954091;9955.253355998184;9962.900370996198;10108.090271875566;10289.536970836181;10618.415987120783;9389.38968967015;9560.307580371047;9562.665306714232;9581.856272155785;9814.06766357195;8975.192232698828;9011.864822027545;9164.954175229348;9229.400088994194;9404.153626173404;9309.581068851783;9313.161815436642;9332.533373331442;9335.953320233355;9772.218222542322;7774.416918731004;7906.7627971160955;7939.642716077906;7965.1238363778775;8048.919510804817;8141.918580814353;8281;8341.791455213426;8419.915800842158;8526.78683032929 11:56:52 INFO - PROCESS | 3401 | __end_tp_report 11:56:52 INFO - PROCESS | 3401 | __start_cc_report 11:56:52 INFO - PROCESS | 3401 | _x_x_mozilla_cycle_collect,970 11:56:52 INFO - PROCESS | 3401 | __end_cc_report 11:56:52 INFO - PROCESS | 3401 | __startTimestamp1464029812304__endTimestamp 11:56:52 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | ------- Summary: start ------- 11:56:52 INFO - PROCESS | 3401 | Number of tests: 6 11:56:52 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | [#0] dojo.html Cycles:165 Average:4716.62 Median:4839.52 stddev:499.75 (10.3%) stddev-sans-first:474.34 11:56:52 INFO - PROCESS | 3401 | Values: 2653.1 2676.8 2704.7 2705.9 2718.0 4608.0 4637.6 4671.5 4716.1 4738.9 4711.9 4717.8 4719.6 4792.5 4796.0 4132.6 4302.9 4388.1 4415.2 4491.6 4396.1 4422.7 4447.3 4447.4 4484.6 4306.2 4315.9 4329.0 4342.8 4359.5 4342.8 4346.2 4348.6 4394.9 4402.1 4345.3 4362.0 4368.7 4401.6 4401.7 4567.2 4633.1 4696.8 4711.0 4718.5 5127.0 5160.7 5181.2 5186.7 5186.7 5170.7 5176.7 5185.1 5189.1 5191.1 4622.1 4743.8 4797.1 4798.6 4864.5 5256.8 5321.1 5321.7 5322.7 5330.5 4832.7 5041.6 5050.4 5051.9 5054.4 5081.2 5119.8 5137.7 5142.5 5159.0 5110.7 5115.5 5116.8 5119.8 5138.4 4942.5 4976.6 5098.1 5101.4 5115.2 4260.2 4270.6 4272.8 4274.1 4283.9 3774.6 3808.2 3818.4 3820.7 3823.2 4419.1 4420.2 4429.5 4455.5 4479.9 5191.7 5196.4 5201.3 5203.9 5240.1 4458.7 4461.1 4462.5 4493.1 4511.3 4438.4 4507.8 4524.1 4541.9 4548.5 4820.5 4820.8 4822.1 4829.3 4839.5 5089.5 5093.9 5094.2 5099.6 5148.5 4690.0 4812.2 4856.2 4878.4 4881.7 5049.0 5068.4 5071.2 5084.7 5128.0 4925.4 5101.8 5113.4 5117.2 5123.2 4874.5 4888.8 4929.2 4946.1 5002.4 4935.9 4941.0 4947.0 4948.9 4991.0 4712.7 4868.2 4876.4 4878.3 4921.8 4960.0 4991.1 5015.3 5017.2 5022.3 4907.1 4907.3 4909.6 4911.1 4958.2 11:56:52 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | [#1] ext.html Cycles:180 Average:44551.97 Median:19623.09 stddev:79716.68 (406.2%) stddev-sans-first:79871.86 11:56:52 INFO - PROCESS | 3401 | Values: 555.3 567.2 588.6 594.0 595.6 40166.4 42192.2 42242.4 44911.8 44988.8 41965.4 42615.8 42644.6 42726.4 42747.0 7613.1 7642.8 7859.7 7860.1 9797.7 9636.6 10039.4 10063.0 10068.7 10075.5 10042.0 10046.0 10126.1 10126.7 10134.4 7510.3 9859.8 9990.3 10157.6 10177.0 9980.9 10070.5 10071.4 10076.6 10094.1 39187.4 39428.4 39567.6 39628.4 39659.4 3123.2 3189.2 3220.8 3487.7 3852.1 30029.2 30117.7 30451.7 30599.5 30949.2 3562.1 3575.7 3588.9 3593.4 3612.8 185275.0 186004.1 186700.0 186956.0 187134.0 32271.5 55472.4 55564.4 55996.7 55999.7 32783.8 34714.7 34724.5 34748.8 34782.0 11054.4 11173.3 11175.2 11185.4 11188.8 7521.7 8094.8 8103.3 8153.4 8268.9 7914.6 7921.9 7956.8 7995.0 8027.8 3087.2 3096.4 3102.6 3132.4 3151.6 926.6 934.0 936.9 954.7 996.1 27769.7 28422.0 28565.6 29096.9 29232.9 964.9 978.8 983.3 988.4 1019.7 15048.5 15520.0 15594.0 15654.3 15754.1 377553.0 380812.0 383258.0 383313.0 383465.0 50195.5 50709.0 50731.5 50780.7 50995.2 1106.0 1185.5 1197.5 1204.3 1221.4 28494.3 29230.0 29338.6 29589.7 30064.2 41947.2 42504.6 42566.8 42641.0 42741.0 299621.0 304626.0 306486.0 307662.0 309211.0 22413.2 22645.0 22992.0 23640.0 27278.2 42380.0 42402.4 42802.6 43194.0 43403.8 35328.9 36204.0 37075.3 37118.0 37283.0 36477.8 36492.8 36814.4 37221.4 37669.0 34756.5 35068.6 35553.8 35684.1 35849.3 32173.8 32909.3 33246.0 33347.2 33529.5 25131.0 25366.5 25535.2 25669.9 25826.1 11:56:52 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | [#2] jquery.html Cycles:180 Average:24667.47 Median:27700.71 stddev:68010.59 (245.5%) stddev-sans-first:68176.91 11:56:52 INFO - PROCESS | 3401 | Values: 367.2 374.3 375.2 380.1 385.7 16407.4 16924.9 17155.2 17319.9 17532.6 16199.2 16553.0 17190.3 17198.5 17222.1 5064.4 5233.3 5248.5 5296.3 5306.5 3778.7 3875.7 3944.8 5160.4 6078.0 6013.1 6140.6 6176.4 6181.6 6183.8 5787.6 6117.0 6127.3 6137.6 6141.4 3399.1 5022.2 5325.2 5394.0 5406.0 20075.6 20539.6 20576.2 20826.5 20847.5 1915.9 1965.0 1980.4 2005.1 2136.8 12886.9 12903.9 13162.0 13243.3 13293.3 1723.3 1736.1 1745.0 1773.1 1841.4 42874.8 43694.5 58124.4 59277.4 68537.3 9867.6 10074.5 10293.4 10297.2 10867.8 14057.2 14132.6 14134.7 14134.9 14187.6 6464.2 6609.7 6649.8 6759.9 6801.7 5997.8 6068.5 6145.9 6169.1 6186.4 6239.9 6301.0 6301.9 6345.2 6370.4 1766.5 1829.4 1841.2 1853.6 1858.6 882.4 886.1 887.1 889.1 931.9 16521.3 16594.2 17014.7 17653.2 17857.7 903.5 904.2 912.8 932.5 953.0 7787.9 9846.8 9917.3 10038.5 10123.0 401519.0 405100.0 415517.0 421716.0 423204.0 76905.0 83656.6 83757.6 84189.6 85003.6 750.7 912.9 940.1 960.5 969.7 15519.8 15878.4 15962.4 16258.8 16282.8 33628.8 33652.8 33825.7 35280.0 35349.0 46476.8 47713.5 50094.0 50379.2 50501.2 7523.7 7524.6 7600.7 7684.3 7781.9 8453.8 10972.3 11153.6 11361.6 11378.6 9425.1 9590.7 9841.9 10012.9 10324.6 9614.6 9967.6 10064.6 10127.6 10246.2 7985.3 8176.3 8797.4 9715.7 9792.7 7552.2 7698.4 7768.8 7776.7 7977.2 9655.7 9809.4 9935.8 9939.6 10151.1 11:56:52 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | [#3] mootools.html Cycles:180 Average:5134.27 Median:5001.84 stddev:2957.02 (59.1%) stddev-sans-first:2951.37 11:56:52 INFO - PROCESS | 3401 | Values: 1312.6 1415.8 1459.5 1571.6 1770.0 6715.1 7667.8 7908.9 7916.4 8113.4 7795.8 7939.6 7952.2 7954.9 7956.0 1840.7 2109.4 2162.6 2203.1 2204.6 2193.4 2215.9 2216.7 2218.9 2227.7 2141.2 2165.3 2181.4 2183.1 2184.3 1777.0 2078.2 2099.7 2148.4 2149.7 2149.2 2165.0 2170.3 2170.5 2174.8 7785.7 7804.5 7804.7 7843.8 7846.4 4257.9 4359.7 4367.0 4367.3 4376.2 2788.9 2846.2 2944.1 2971.1 2981.2 939.6 948.9 949.0 958.2 958.4 10824.7 10836.2 10858.8 10860.1 10865.5 4173.1 4173.6 4275.9 4285.8 4287.6 9196.5 9274.7 9276.6 9278.6 9295.9 4319.1 4369.7 4403.1 4408.7 4412.5 3394.0 3802.9 3940.7 3962.3 3979.8 3539.3 3608.2 3635.2 3664.5 3687.2 1194.4 1196.2 1213.8 1222.4 1222.6 664.7 752.7 754.8 801.0 848.0 4821.9 4885.8 4895.3 4901.7 5034.7 856.3 861.0 868.2 869.2 872.8 3260.1 3326.5 3356.1 3376.7 3439.6 9602.8 9791.9 9924.1 9953.8 9974.0 9764.6 9848.1 9872.0 9876.7 9884.0 7396.9 7397.7 7523.2 7552.2 7560.3 4979.1 4996.3 5007.4 5073.8 5110.0 9073.8 9090.7 9110.5 9125.8 9205.4 8761.1 9123.4 9136.1 9451.6 9451.8 6153.1 6293.5 6410.4 6500.7 6649.7 7667.5 7696.0 7753.9 7765.4 7774.8 6859.4 6937.9 6961.1 6963.1 7131.8 6761.0 6778.8 6783.2 6898.1 6967.3 6225.3 6249.5 6258.5 6319.1 6319.2 4472.6 4492.7 4511.2 4569.7 4604.8 4403.3 4432.8 4439.2 4465.9 4611.3 11:56:52 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | [#4] prototype.html Cycles:180 Average:4010.17 Median:4387.02 stddev:1146.88 (26.1%) stddev-sans-first:1115.58 11:56:52 INFO - PROCESS | 3401 | Values: 289.8 299.2 302.3 306.0 306.4 4639.7 4789.0 4798.2 4832.2 4864.9 4605.2 4719.5 4738.3 4747.1 4751.2 3759.3 3768.4 3796.6 3800.5 3807.7 3547.2 3642.4 3800.8 3803.3 3808.9 3751.8 3756.9 3789.8 3796.1 3804.7 3747.0 3754.8 3766.4 3769.3 3795.7 3356.7 3372.7 3377.4 3393.5 3402.6 4473.8 4579.2 4580.2 4581.5 4584.7 4282.1 4287.5 4310.0 4310.3 4316.2 4796.0 4889.3 4914.2 4963.2 4996.5 3552.8 3571.7 3572.3 3573.4 3576.2 5213.3 5216.3 5227.4 5235.2 5241.4 3671.5 3678.1 3682.8 3698.4 3698.7 3554.3 3683.5 3698.4 3702.8 3720.2 4226.3 4227.5 4256.6 4257.3 4277.4 4745.5 4926.6 4989.7 5003.8 5007.1 1228.7 1268.4 1275.8 1281.4 1284.2 802.6 818.2 820.8 821.4 832.6 3987.8 3995.3 3995.4 4000.6 4046.9 4525.3 4530.4 4609.6 4622.4 4658.7 4045.4 4077.3 4081.3 4101.2 4111.8 2393.3 2485.4 2493.4 2496.8 2497.8 4271.7 4356.0 4375.9 4389.7 4415.8 4659.7 4666.7 4668.8 4672.5 4683.0 4039.7 4352.5 4374.7 4384.3 4384.3 4572.0 4580.3 4581.7 4586.4 4587.6 4439.5 4459.3 4508.9 4522.4 4535.0 3980.6 4335.7 4373.5 4394.0 4448.0 3350.8 3390.6 3406.3 3412.7 3413.6 4522.9 4530.7 4578.9 4629.9 4920.8 4827.9 4986.6 5056.4 5063.7 5067.7 5018.7 5034.7 5036.3 5044.6 5058.3 4786.6 4929.5 4961.4 4967.8 4979.7 5047.8 5062.4 5065.7 5101.1 5114.8 4979.9 4987.1 4990.7 5000.7 5002.9 11:56:52 INFO - PROCESS | 3401 | 11:56:52 INFO - PROCESS | 3401 | [#5] yui.html Cycles:180 Average:13043.30 Median:27836.69 stddev:15696.26 (56.4%) stddev-sans-first:15712.76 11:56:52 INFO - PROCESS | 3401 | Values: 663.1 671.1 721.2 761.4 795.7 12213.6 13102.1 13124.8 13282.4 13313.0 12404.8 12659.7 12679.8 12681.1 12706.4 637.7 802.2 802.9 821.2 828.5 818.6 818.9 822.9 823.4 823.5 854.3 860.2 860.5 860.7 861.4 514.7 827.3 849.6 851.8 853.8 621.7 623.0 623.7 623.8 624.1 12408.5 12441.2 12444.5 12462.9 12466.0 11714.5 12094.8 12138.9 12208.2 12412.3 9836.2 9907.4 10097.4 10164.2 11251.8 4184.7 4187.0 4221.4 4230.4 4291.4 46777.8 46959.0 47009.1 47015.3 47220.5 9792.0 9914.7 10013.4 10048.5 10123.2 16958.2 17292.3 17297.1 17320.1 17331.0 6528.1 6536.8 6543.5 6699.3 6704.6 3733.2 3814.8 3840.3 3847.7 3922.7 2732.9 2802.7 2804.3 2806.0 2806.3 494.9 498.8 502.0 502.1 512.1 548.7 555.1 573.1 579.5 583.1 7792.2 7893.7 7906.6 8010.4 8181.2 448.2 493.1 515.5 520.6 527.6 3541.3 3612.6 3615.3 3636.1 3736.5 55124.7 55762.0 56877.0 57174.1 57519.0 49918.0 51324.0 51432.5 52265.0 52624.7 46465.5 46827.0 47607.8 47715.0 48031.3 7272.9 7358.1 7386.4 7457.9 7475.9 31646.7 32015.4 32156.8 32190.7 32763.3 38572.2 40636.6 41353.4 41970.0 42044.8 9207.6 9310.2 9315.6 9345.1 9378.3 9955.3 9962.9 10108.1 10289.5 10618.4 9389.4 9560.3 9562.7 9581.9 9814.1 8975.2 9011.9 9165.0 9229.4 9404.2 9309.6 9313.2 9332.5 9336.0 9772.2 7774.4 7906.8 7939.6 7965.1 8048.9 8141.9 8281.0 8341.8 8419.9 8526.8 11:56:52 INFO - PROCESS | 3401 | -------- Summary: end -------- 11:56:52 INFO - PROCESS | 3401 | 11:56:53 INFO - TEST-INFO | 3401: exit 0 11:56:53 INFO - TEST-OK | dromaeo_css | took 1119014ms 11:56:53 INFO - TEST-START | kraken 11:56:53 INFO - operating with platform_type : linux_ 11:56:53 INFO - Initialising browser for kraken test... 11:56:53 INFO - TEST-INFO | started process 3575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgjd4q5/profile http://localhost:55537/getInfo.html) 11:56:57 INFO - PROCESS | 3575 | __metrics Screen width/height:1600/1200 11:56:57 INFO - PROCESS | 3575 | colorDepth:24 11:56:57 INFO - PROCESS | 3575 | Browser inner width/height: 1024/697 11:56:57 INFO - PROCESS | 3575 | __metrics 11:56:58 ERROR - PROCESS | 3575 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:56:59 INFO - TEST-INFO | 3575: exit 0 11:56:59 INFO - Browser initialized. 11:56:59 INFO - Running cycle 1/1 for kraken test... 11:56:59 INFO - TEST-INFO | started process 3655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgjd4q5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:11 INFO - PROCESS | 3655 | RSS: Main: 154714112 11:57:11 INFO - PROCESS | 3655 | 11:57:14 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-beat-detection) 11:57:15 INFO - PROCESS | 3655 | RSS: Main: 209571840 11:57:15 INFO - PROCESS | 3655 | 11:57:17 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-dft) 11:57:18 INFO - PROCESS | 3655 | RSS: Main: 197402624 11:57:18 INFO - PROCESS | 3655 | 11:57:21 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-fft) 11:57:22 INFO - PROCESS | 3655 | RSS: Main: 266850304 11:57:22 INFO - PROCESS | 3655 | 11:57:24 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-oscillator) 11:57:25 INFO - PROCESS | 3655 | RSS: Main: 175915008 11:57:25 INFO - PROCESS | 3655 | 11:57:27 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:57:28 INFO - PROCESS | 3655 | RSS: Main: 180338688 11:57:28 INFO - PROCESS | 3655 | 11:57:31 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:32 INFO - PROCESS | 3655 | RSS: Main: 216236032 11:57:32 INFO - PROCESS | 3655 | 11:57:36 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:36 INFO - PROCESS | 3655 | RSS: Main: 214384640 11:57:36 INFO - PROCESS | 3655 | 11:57:39 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55537/tests/kraken/driver.html?testName=json-parse-financial) 11:57:40 INFO - PROCESS | 3655 | RSS: Main: 215883776 11:57:40 INFO - PROCESS | 3655 | 11:57:42 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55537/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:42 INFO - PROCESS | 3655 | RSS: Main: 208134144 11:57:42 INFO - PROCESS | 3655 | 11:57:44 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:45 INFO - PROCESS | 3655 | RSS: Main: 212586496 11:57:45 INFO - PROCESS | 3655 | 11:57:47 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:57:48 INFO - PROCESS | 3655 | RSS: Main: 217030656 11:57:48 INFO - PROCESS | 3655 | 11:57:51 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:57:51 INFO - PROCESS | 3655 | RSS: Main: 219062272 11:57:51 INFO - PROCESS | 3655 | 11:57:54 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:57:55 INFO - PROCESS | 3655 | RSS: Main: 219004928 11:57:55 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55537/tests/kraken/driver.html?testName=ai-astar) 11:57:57 INFO - PROCESS | 3655 | RSS: Main: 265965568 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | __start_tp_report 11:57:57 INFO - PROCESS | 3655 | _x_x_mozilla_page_load 11:57:57 INFO - PROCESS | 3655 | _x_x_mozilla_page_load_details 11:57:57 INFO - PROCESS | 3655 | |i|pagename|runs| 11:57:57 INFO - PROCESS | 3655 | |0;ai-astar;115;109;114;114;115;115;115;114;114;115 11:57:57 INFO - PROCESS | 3655 | |1;audio-beat-detection;160;133;131;207;138;141;151;130;163;130 11:57:57 INFO - PROCESS | 3655 | |2;audio-dft;163;162;164;162;163;161;164;162;164;162 11:57:57 INFO - PROCESS | 3655 | |3;audio-fft;77;78;77;136;76;76;84;75;129;76 11:57:57 INFO - PROCESS | 3655 | |4;audio-oscillator;95;94;159;93;93;94;124;93;94;130 11:57:57 INFO - PROCESS | 3655 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;116 11:57:57 INFO - PROCESS | 3655 | |6;imaging-darkroom;146;146;146;146;148;146;146;146;145;146 11:57:57 INFO - PROCESS | 3655 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;94;94 11:57:57 INFO - PROCESS | 3655 | |8;json-parse-financial;64;64;64;64;67;65;64;65;63;64 11:57:57 INFO - PROCESS | 3655 | |9;json-stringify-tinderbox;65;64;65;65;65;65;64;64;65;65 11:57:57 INFO - PROCESS | 3655 | |10;stanford-crypto-aes;89;88;83;83;83;89;84;83;148;90 11:57:57 INFO - PROCESS | 3655 | |11;stanford-crypto-ccm;131;131;128;130;144;134;134;137;157;133 11:57:57 INFO - PROCESS | 3655 | |12;stanford-crypto-pbkdf2;173;171;173;173;169;177;169;171;173;169 11:57:57 INFO - PROCESS | 3655 | |13;stanford-crypto-sha256-iterative;69;68;65;70;66;69;66;65;65;64 11:57:57 INFO - PROCESS | 3655 | __end_tp_report 11:57:57 INFO - PROCESS | 3655 | __start_cc_report 11:57:57 INFO - PROCESS | 3655 | _x_x_mozilla_cycle_collect,2136 11:57:57 INFO - PROCESS | 3655 | __end_cc_report 11:57:57 INFO - PROCESS | 3655 | __startTimestamp1464029877513__endTimestamp 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | ------- Summary: start ------- 11:57:57 INFO - PROCESS | 3655 | Number of tests: 14 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:1.83 (1.6%) stddev-sans-first:1.90 11:57:57 INFO - PROCESS | 3655 | Values: 115.0 109.0 114.0 114.0 115.0 115.0 115.0 114.0 114.0 115.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:146.00 stddev:23.96 (16.4%) stddev-sans-first:25.05 11:57:57 INFO - PROCESS | 3655 | Values: 160.0 133.0 131.0 207.0 138.0 141.0 151.0 130.0 163.0 130.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.12 11:57:57 INFO - PROCESS | 3655 | Values: 163.0 162.0 164.0 162.0 163.0 161.0 164.0 162.0 164.0 162.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#3] audio-fft Cycles:10 Average:88.40 Median:76.50 stddev:23.43 (30.6%) stddev-sans-first:24.49 11:57:57 INFO - PROCESS | 3655 | Values: 77.0 78.0 77.0 136.0 76.0 76.0 84.0 75.0 129.0 76.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:93.50 stddev:23.00 (24.6%) stddev-sans-first:23.99 11:57:57 INFO - PROCESS | 3655 | Values: 95.0 94.0 159.0 93.0 93.0 94.0 124.0 93.0 94.0 130.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:57:57 INFO - PROCESS | 3655 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:57:57 INFO - PROCESS | 3655 | Values: 146.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 145.0 146.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:57:57 INFO - PROCESS | 3655 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 11:57:57 INFO - PROCESS | 3655 | Values: 64.0 64.0 64.0 64.0 67.0 65.0 64.0 65.0 63.0 64.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:57:57 INFO - PROCESS | 3655 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:86.00 stddev:19.89 (23.1%) stddev-sans-first:21.07 11:57:57 INFO - PROCESS | 3655 | Values: 89.0 88.0 83.0 83.0 83.0 89.0 84.0 83.0 148.0 90.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:134.00 stddev:8.65 (6.5%) stddev-sans-first:8.99 11:57:57 INFO - PROCESS | 3655 | Values: 131.0 131.0 128.0 130.0 144.0 134.0 134.0 137.0 157.0 133.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:173.00 stddev:2.53 (1.5%) stddev-sans-first:2.65 11:57:57 INFO - PROCESS | 3655 | Values: 173.0 171.0 173.0 173.0 169.0 177.0 169.0 171.0 173.0 169.0 11:57:57 INFO - PROCESS | 3655 | 11:57:57 INFO - PROCESS | 3655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.11 (3.2%) stddev-sans-first:2.07 11:57:57 INFO - PROCESS | 3655 | Values: 69.0 68.0 65.0 70.0 66.0 69.0 66.0 65.0 65.0 64.0 11:57:57 INFO - PROCESS | 3655 | -------- Summary: end -------- 11:57:57 INFO - PROCESS | 3655 | 11:57:58 INFO - TEST-INFO | 3655: exit 0 11:57:58 INFO - TEST-OK | kraken | took 65422ms 11:57:58 INFO - SUITE-END | took 1184s 11:57:58 INFO - Completed test suite (00:19:44) 11:57:58 INFO - javascript benchmark 11:57:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.0714250012497, 2676.8393896366206, 2704.7160048194937, 2705.8782354794034, 2717.9864100679492, 4608.0, 4637.6289896808175, 4671.4627817800965, 4716.056788642268, 4738.881527961803, 4711.9162592603725, 4717.834875779348, 4719.622430205584, 4792.496787837279, 4796.0, 4132.628063474287, 4302.913941721155, 4388.100439409914, 4415.183191109639, 4491.573300536444, 4396.1427521633295, 4422.7125236859665, 4447.332900065, 4447.35513350564, 4484.573965473275, 4306.2248795217, 4315.892102697458, 4328.956710432887, 4342.804573794187, 4359.455068116486, 4342.826286948518, 4346.239408103601, 4348.608625223745, 4394.868153955386, 4402.119576084796, 4345.348197770328, 4362.040351122748, 4368.650507959355, 4401.559844015573, 4401.669874759374, 4567.1779079765965, 4633.119707255611, 4696.81212751493, 4711.03423798124, 4718.528147185254, 5127.0258650856595, 5160.664556803796, 5181.248718935771, 5186.662866913676, 5186.688798672054, 5170.741462926876, 5176.663516871391, 5185.066687996159, 5189.143791274435, 5191.117510023268, 4622.052479241747, 4743.810247590127, 4797.064572408417, 4798.568128868418, 4864.489228630943, 5256.789728410898, 5321.122014867581, 5321.680699158062, 5322.654027488201, 5330.546903513245, 4832.734199619054, 5041.647084704109, 5050.444451110375, 5051.87370315745, 5054.444011158769, 5081.161608334657, 5119.846404607868, 5137.717425541631, 5142.485751424828, 5159.045576568272, 5110.718910459886, 5115.462876397924, 5116.846494605168, 5119.795208191705, 5138.434772175057, 4942.5304596063315, 4976.601871850244, 5098.107831129538, 5101.438841727407, 5115.18157094863, 4260.190563792869, 4270.551592082787, 4272.829086836554, 4274.10243848789, 4283.87148385549, 3774.5659249186147, 3808.21931504041, 3818.3508803503473, 3820.656140947328, 3823.158905040942, 4419.0940857124215, 4420.248557745191, 4429.49060857999, 4455.465344158657, 4479.888002799956, 5191.714455704972, 5196.428392876781, 5201.3238279024245, 5203.947960520422, 5240.135377662719, 4458.7324760514475, 4461.063176732858, 4462.464504259445, 4493.0789188216995, 4511.255642818964, 4438.4451943507065, 4507.797149128297, 4524.140413321458, 4541.886452838706, 4548.522405147478, 4820.493848145964, 4820.807167713322, 4822.13201623697, 4829.348038014823, 4839.516048395132, 5089.491050894881, 5093.8726531837, 5094.15946368845, 5099.6175286852895, 5148.4851514848215, 4690.0, 4812.205986012269, 4856.223004319292, 4878.414590249193, 4881.731504767272, 5049.040682270357, 5068.417132029864, 5071.18860982241, 5084.745762711924, 5127.974360128175, 4925.433575138762, 5101.821436249714, 5113.360829896263, 5117.2068329409, 5123.23151527259, 4874.53691899269, 4888.780004899859, 4929.186684197068, 4946.109700253989, 5002.399712034579, 4935.851924442272, 4941.0, 4947.0, 4948.925766113583, 4991.0, 4712.69367491112, 4868.17241069012, 4876.390451193601, 4878.317035614946, 4921.753912304442, 4960.0, 4991.126552853164, 5015.322931404214, 5017.197248440232, 5022.3219865317715, 4907.092187945242, 4907.337509436323, 4909.607231421406, 4911.066897289504, 4958.206686930218], "value": 4684.844290400307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.253184466892, 567.248395875465, 588.5615216663581, 593.9821805345838, 595.6217801695924, 40166.39750403743, 42192.156156876845, 42242.366364504516, 44911.77544112283, 44988.77505612475, 41965.37051944216, 42615.78692106535, 42644.57355426445, 42726.35910461338, 42747.0, 7613.124490683587, 7642.808929776745, 7859.68561257549, 7860.056793184797, 9797.706068817946, 9636.61453541861, 10039.397636141855, 10063.0, 10068.74828129299, 10075.546600402999, 10042.0, 10046.0, 10126.088652021317, 10126.746831329203, 10134.391936483798, 7510.286522780327, 9859.802803943881, 9990.300678952477, 10157.644482443078, 10177.0, 9980.850287245697, 10070.496475176213, 10071.395716257048, 10076.647317343932, 10094.141997930185, 39187.412188817194, 39428.40857387141, 39567.60432395668, 39628.40557391642, 39659.40510892339, 3123.1723593247807, 3189.1548739584027, 3220.806751594912, 3487.6512348764923, 3852.0755018795567, 30029.24926876824, 30117.69882301171, 30451.69548304533, 30599.541006884916, 30949.22626934322, 3562.0738607961857, 3575.7496975211748, 3588.946165807515, 3593.4250519916686, 3612.801295928723, 185275.0, 186004.06997965058, 186700.0, 186956.0, 187134.0, 32271.51592726111, 55472.445275547536, 55564.444355556734, 55996.72001639966, 55999.720001399735, 32783.83608081944, 34714.65285347165, 34724.47913281303, 34748.82625586856, 34782.0, 11054.447277636247, 11173.273737207055, 11175.161862860317, 11185.440727963569, 11188.776224475465, 7521.736739214101, 8094.757157285291, 8103.3112185463715, 8153.429259951747, 8268.875966860502, 7914.643841027168, 7921.881171782428, 7956.761297161094, 7994.960025199953, 8027.839443211103, 3087.1664650544226, 3096.442640324718, 3102.5811515445125, 3132.4048430798075, 3151.558781770554, 926.5737760630051, 933.9859902101474, 936.9063093690577, 954.6801821389912, 996.0537489385113, 27769.722302776714, 28422.0, 28565.57499925044, 29096.854515727286, 29232.853835730686, 964.8855571814565, 978.7602037500858, 983.2772911909741, 988.3773222869546, 1019.6635110413546, 15048.548543543711, 15520.0, 15594.0, 15654.295556699975, 15754.054756714633, 377553.0, 380812.0, 383258.0, 383313.0, 383465.0, 50195.49804501981, 50709.0, 50731.49268507268, 50780.746096269286, 50995.23507147396, 1106.0, 1185.4791269928298, 1197.4910662968205, 1204.3195594489086, 1221.419825582841, 28494.287642808267, 29230.0, 29338.559921600765, 29589.704102958694, 30064.24839379033, 41947.1610567793, 42504.57495425006, 42566.78716606397, 42641.0, 42741.0, 299621.0, 304626.0, 306486.0, 307662.0, 309211.0, 22413.21553745611, 22645.0, 22992.0, 23640.0, 27278.181654550393, 42380.0, 42402.36396453994, 42802.57197427986, 43194.0, 43403.78298108489, 35328.88026718405, 36204.0, 37075.25849482941, 37118.0, 37283.0, 36477.81761091178, 36492.81753591215, 36814.44778328381, 37221.441678375384, 37669.0, 34756.47865282073, 35068.64931350654, 35553.82223088868, 35684.107897302776, 35849.283014339046, 32173.839130804197, 32909.31432295416, 33246.0, 33347.166320842174, 33529.49705754464, 25131.0, 25366.492670146126, 25535.23394298174, 25669.871650641628, 25826.096086636877], "value": 16809.925775430907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.2178260305548, 374.2813797508783, 375.1877185892543, 380.1408816075668, 385.74155315938316, 16407.425740099097, 16924.915375423105, 17155.228014739336, 17319.91340043301, 17532.56168595784, 16199.190040497957, 16553.0, 17190.312387504484, 17198.484045478624, 17222.13889305533, 5064.442911279765, 5233.267342572043, 5248.501392367719, 5296.311479507659, 5306.469353064682, 3778.7165962552917, 3875.670568001709, 3944.7830369329677, 5160.406553246368, 6077.969610151965, 6013.067974463965, 6140.570160088796, 6176.444120029197, 6181.598196117238, 6183.845403864894, 5787.594868359217, 6117.021276595746, 6127.325994140641, 6137.631742095444, 6141.385861413867, 3399.1332210286464, 5022.17134172861, 5325.201219817059, 5393.973030134864, 5406.0, 20075.598488030304, 20539.5892082159, 20576.176952921865, 20826.47933801652, 20847.478813029644, 1915.9137838797287, 1964.9607007859763, 1980.366282789508, 2005.0776642744356, 2136.83973701973, 12886.87113128866, 12903.935480322538, 13162.0, 13243.337833108402, 13293.335333233397, 1723.2503860820584, 1736.1492868494347, 1744.9912750436167, 1773.1488885335111, 1841.4475657302755, 42874.785626071985, 43694.49733387308, 58124.41875581232, 59277.40722592762, 68537.3146268536, 9867.605295788231, 10074.496275186211, 10293.43386113771, 10297.227707921937, 10867.78264434707, 14057.226852523005, 14132.646683832781, 14134.717305653829, 14134.929325353307, 14187.574372768833, 6464.159659244268, 6609.735610575523, 6649.767258145942, 6759.898601520981, 6801.65991700413, 5997.820065398045, 6068.4538391544975, 6145.907811382833, 6169.105479705418, 6186.381361863778, 6239.906401403982, 6300.9684951574945, 6301.905471417932, 6345.206849143857, 6370.394812492806, 1766.4788887278285, 1829.4054432309554, 1841.1714728372285, 1853.5829438376256, 1858.6189831084596, 882.3823323673454, 886.1050339157497, 887.0863011098579, 889.0842432294746, 931.9301052421096, 16521.256543455573, 16594.170291485378, 17014.659706806044, 17653.20560574777, 17857.732134018, 903.4669544968368, 904.2404380320562, 912.7581190984395, 932.4871320773683, 952.9618815247312, 7787.92212077872, 9846.753831154278, 9917.256205784595, 10038.548265328078, 10123.03831136041, 401519.0, 405100.0, 415517.0, 421716.0, 423204.0, 76905.0, 83656.58171709103, 83757.58121209354, 84189.57905210435, 85003.57498212592, 750.6884642873256, 912.9132732390412, 940.1209868772582, 960.5389413081759, 969.6509256667593, 15519.76720349173, 15878.412158784491, 15962.361505539648, 16258.837411625733, 16282.837171628606, 33628.831855840566, 33652.831735841166, 33825.661743383236, 35280.0, 35349.0, 46476.76761616306, 47713.52286477091, 50094.0, 50379.24431133462, 50501.242481363544, 7523.699052038076, 7524.5861477619255, 7600.695972161052, 7684.346830519468, 7781.883271751041, 8453.788655283666, 10972.341659500455, 11153.553857845594, 11361.602343917923, 11378.601748938747, 9425.05749425052, 9590.66432674853, 9841.852372214566, 10012.949935250277, 10324.638637647646, 9614.615415383587, 9967.551460184453, 10064.597416103567, 10127.64553240633, 10246.180305575685, 7985.321247694011, 8176.305014073871, 8797.428167169113, 9715.70852874415, 9792.706218813448, 7552.244775522404, 7698.422618303538, 7768.84462310762, 7776.7278145264645, 7977.2022797719765, 9655.662051828152, 9809.362391444532, 9935.751606209902, 9939.602415903282, 10151.086402223835], "value": 8261.942199352601, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.573413640567, 1415.801787749715, 1459.5475402625184, 1571.6228105254743, 1769.955751106223, 6715.127033485646, 7667.846643067135, 7908.92091079089, 7916.445848790587, 8113.43205975582, 7795.844083118334, 7939.5633240171765, 7952.165022672622, 7954.92045079549, 7956.045274567045, 1840.6778813707615, 2109.4199095248778, 2162.5782972320403, 2203.10774136475, 2204.6362350212194, 2193.396815875639, 2215.9224427144973, 2216.7007453993747, 2218.8557743746687, 2227.7326720793526, 2141.15424407359, 2165.307101727448, 2181.4437318483765, 2183.072194317409, 2184.3010236724253, 1776.9555761105946, 2078.1791192478886, 2099.6745504446835, 2148.366231961575, 2149.720536330267, 2149.18331034206, 2164.9567008659897, 2170.3271985684487, 2170.4573856535867, 2174.826013918883, 7785.688572457095, 7804.492707973964, 7804.72683456082, 7843.803904902366, 7846.372290216826, 4257.893552661178, 4359.738415695068, 4367.0, 4367.344898265285, 4376.23415902219, 2788.9302767430772, 2846.217290245199, 2944.1020488750924, 2971.1235185620076, 2981.1950773291305, 939.6053657463882, 948.9335746497748, 949.0, 958.1759686669459, 958.4441024206013, 10824.729381765519, 10836.187285953585, 10858.837117443245, 10860.076893464066, 10865.51105200268, 4173.10278290169, 4173.582641735802, 4275.87172384829, 4285.8285668573535, 4287.5926786955815, 9196.494192819326, 9274.675386361445, 9276.582553785096, 9278.62885484573, 9295.860562091573, 4319.071399649028, 4369.737815731066, 4403.119376124788, 4408.735475871458, 4412.4705035395955, 3394.0496660934978, 3802.9429558556644, 3940.7241493095207, 3962.306596345628, 3979.8408063677707, 3539.309834582232, 3608.2061946371755, 3635.2184280379847, 3664.5052917856283, 3687.2441149564274, 1194.4386138514883, 1196.2045239915358, 1213.805791073424, 1222.443788076423, 1222.5598784437595, 664.7473959895209, 752.7440670172168, 754.7773406844993, 801.0107517216234, 848.0332421039896, 4821.855344339676, 4885.828995985124, 4895.31465594817, 4901.730404827768, 5034.748262586856, 856.2850020233175, 860.9956950215209, 868.2418103340785, 869.2437579305918, 872.7992561710842, 3260.103471545344, 3326.5010248462922, 3356.0938546592283, 3376.679215474526, 3439.604445488801, 9602.807943841084, 9791.853122203172, 9924.1068303853, 9953.80092398148, 9974.002599739968, 9764.560594773111, 9848.06443387877, 9872.0, 9876.65431709901, 9883.950580247196, 7396.852062958711, 7397.667104980181, 7523.172451030382, 7552.169261381244, 7560.319571238615, 4979.128652485873, 4996.3005179274205, 5007.37407824022, 5073.847784566469, 5110.029094472038, 9073.818523629623, 9090.727278181665, 9110.453372797654, 9125.817483650422, 9205.355625106178, 8761.123887611187, 9123.406978546373, 9136.132067453582, 9451.574679139318, 9451.763705907408, 6153.107799369156, 6293.496520278458, 6410.358964103552, 6500.7399704013205, 6649.667516624053, 7667.463277570517, 7696.0, 7753.883691744515, 7765.378769698524, 7774.766756997299, 6859.416949559343, 6937.930620693728, 6961.095057642677, 6963.1296087989, 7131.750388736369, 6761.0, 6778.762743303961, 6783.152105986752, 6898.1377327834025, 6967.303269672992, 6225.28409232944, 6249.531285153541, 6258.4680302173, 6319.115323854572, 6319.24169099711, 4472.642188624967, 4492.663050271178, 4511.210538155744, 4569.725816451024, 4604.769761511978, 4403.295472724477, 4432.800523976364, 4439.156560253541, 4465.910681786411, 4611.331356953156], "value": 4105.726565757413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.82610433739745, 299.1623454327882, 302.3288299974058, 305.977051721121, 306.41780616828026, 4639.721616703, 4788.97605511972, 4798.232282834742, 4832.154372984731, 4864.878378040551, 4605.240135377667, 4719.457262414823, 4738.336632871401, 4747.145513807513, 4751.192297309457, 3759.3045286621996, 3768.3970564709653, 3796.5573082228716, 3800.5059342285463, 3807.714421418391, 3547.2018795771005, 3642.362586547357, 3800.771953682774, 3803.2583646189005, 3808.923821523582, 3751.8499260029703, 3756.887293381203, 3789.810509474515, 3796.126890815114, 3804.657580817726, 3747.025773298935, 3754.774713517184, 3766.4181043961603, 3769.264993326275, 3795.658390744846, 3356.6978971892404, 3372.6627337266077, 3377.392069427502, 3393.52490651309, 3402.6427225141497, 4473.80783416127, 4579.175748365293, 4580.152671755736, 4581.473130589991, 4584.724916504987, 4282.143571285756, 4287.48550173978, 4309.978450107761, 4310.288802347609, 4316.158349121923, 4795.952040479586, 4889.29105279736, 4914.21372580389, 4963.195794376202, 4996.500349965011, 3552.7690700104667, 3571.7141828941562, 3572.2855428914063, 3573.3925232710503, 3576.213233088716, 5213.2701421800975, 5216.295800066942, 5227.372715274191, 5235.240890070956, 5241.371035475768, 3671.5227020487164, 3678.1172518595345, 3682.779033258013, 3698.4452332149854, 3698.68561172298, 3554.2713743682484, 3683.502727131803, 3698.3712768829364, 3702.8150991682405, 3720.162963333228, 4226.344916537942, 4227.450431443954, 4256.638185754246, 4257.340112282601, 4277.401163837066, 4745.525447455227, 4926.58124059459, 4989.725565093882, 5003.7998480061115, 5007.148784706608, 1228.6989687526614, 1268.3594784633885, 1275.7639836630253, 1281.4297637551388, 1284.2422970447294, 802.5545822068808, 818.2390376949376, 820.827626198505, 821.4373154389262, 832.6169961817511, 3987.8205480752854, 3995.320795464778, 3995.380715989026, 4000.579939106352, 4046.9392959105635, 4525.343825145335, 4530.369067135828, 4609.608183304456, 4622.422197225347, 4658.720476771405, 4045.3527435610163, 4077.2864748668862, 4081.3469844824685, 4101.241270364992, 4111.835526578903, 2393.34183099649, 2485.3538080098942, 2493.4140476987895, 2496.8015352630837, 2497.7627125423055, 4271.67962402821, 4356.0, 4375.934360984587, 4389.692721509464, 4415.779211039435, 4659.65052621048, 4666.7066299005, 4668.778542805453, 4672.528153631595, 4682.9765851171205, 4039.6970227232487, 4352.455943007124, 4374.693771436033, 4384.2765943620225, 4384.342348647729, 4571.977140114278, 4580.267157254823, 4581.656375771897, 4586.403767510203, 4587.587117159472, 4439.489458712289, 4459.331100334846, 4508.864734057984, 4522.389477420637, 4535.049928530763, 3980.6218409251073, 4335.7181783184, 4373.518912919512, 4394.0, 4448.0, 3350.765446418727, 3390.6270310266345, 3406.3187362527096, 3412.652002458965, 3413.573303337083, 4522.909541809211, 4530.6505754476075, 4578.92395287114, 4629.851700843459, 4920.803167873245, 4827.937853672186, 4986.601071914166, 5056.381957773478, 5063.746812659426, 5067.682402575283, 5018.72022634226, 5034.723090230073, 5036.330744705312, 5044.646874718735, 5058.26655134996, 4786.593139583035, 4929.457759646508, 4961.444855899287, 4967.801287948586, 4979.726115063706, 5047.823326183566, 5062.443131255633, 5065.746712664279, 5101.107306221471, 5114.820981265638, 4979.900401992012, 4987.12725273083, 4990.72551009698, 5000.67495612784, 5002.874928126826], "value": 3649.921841106703, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.0617675988476, 671.1208317104594, 721.1886627544013, 761.3642608421967, 795.6697970342308, 12213.572524961628, 13102.14836035657, 13124.803127953064, 13282.402291896864, 13313.0, 12404.81392779109, 12659.734026597358, 12679.809802852964, 12681.112322137455, 12706.428210730517, 637.7480895046453, 802.1897883138014, 802.8594995875727, 821.2239433735123, 828.4532208742231, 818.553888130967, 818.868980963046, 822.8971378577678, 823.423603477565, 823.5388182617723, 854.3250831842837, 860.2129051917487, 860.5009094725044, 860.6729442811722, 861.3841103610916, 514.7297668723912, 827.3422629009951, 849.587949844325, 851.7998270406449, 853.803625166209, 621.7419770795115, 623.0094150301043, 623.688155922039, 623.7567348733998, 624.09506215987, 12408.503659853595, 12441.191322564004, 12444.502219911192, 12462.937685311606, 12466.0, 11714.53141874324, 12094.758104837942, 12138.878611213862, 12208.206466579644, 12412.317322547256, 9836.163926066292, 9907.356021858555, 10097.394156350569, 10164.237682173867, 11251.83122253167, 4184.727992680466, 4186.979065104655, 4221.409002739619, 4230.386593943861, 4291.35629655551, 46777.76611116956, 46959.0, 47009.05981880378, 47015.29477057847, 47220.52779472196, 9792.0, 9914.702558923243, 10013.39919604826, 10048.474253019696, 10123.240756943258, 16958.23687934046, 17292.308307667805, 17297.13514324304, 17320.133993300286, 17331.0, 6528.08606795049, 6536.803895883131, 6543.476521878239, 6699.263081061079, 6704.59772413647, 3733.197362567061, 3814.8474061037805, 3840.2703486337505, 3847.7498962567342, 3922.725409221327, 2732.945341093167, 2802.719728027181, 2804.298925268683, 2806.0, 2806.3264816444316, 494.8713334533047, 498.8027737814931, 501.9749012549358, 502.0636512903409, 512.0987062769552, 548.6598309048416, 555.1145922253999, 573.0830670926567, 579.5421616922669, 583.107844997155, 7792.220777922275, 7893.684252629945, 7906.644201010969, 8010.3992200584025, 8181.18188181189, 448.1954890970715, 493.117319997201, 515.5051150895108, 520.5809323494548, 527.6438404077232, 3541.3448512025357, 3612.6026137124895, 3615.313090512794, 3636.07280143567, 3736.4582135590185, 55124.72437637786, 55762.0, 56877.0, 57174.142387864216, 57519.0, 49918.0, 51324.0, 51432.485675143515, 52265.0, 52624.73687631537, 46465.53534464612, 46827.0, 47607.76196119066, 47715.0, 48031.27953080706, 7272.854542909006, 7358.11702595692, 7386.372158366599, 7457.925420745723, 7475.925240747741, 31646.683533165295, 32015.35969280555, 32156.83921580377, 32190.67809321877, 32763.34473310568, 38572.2285554293, 40636.59363406328, 41353.379699303936, 41970.0, 42044.78977605092, 9207.631694732136, 9310.162085412345, 9315.580798863932, 9345.0654934506, 9378.343515954091, 9955.253355998184, 9962.900370996198, 10108.090271875566, 10289.536970836181, 10618.415987120783, 9389.38968967015, 9560.307580371047, 9562.665306714232, 9581.856272155785, 9814.06766357195, 8975.192232698828, 9011.864822027545, 9164.954175229348, 9229.400088994194, 9404.153626173404, 9309.581068851783, 9313.161815436642, 9332.533373331442, 9335.953320233355, 9772.218222542322, 7774.416918731004, 7906.7627971160955, 7939.642716077906, 7965.1238363778775, 8048.919510804817, 8141.918580814353, 8281.0, 8341.791455213426, 8419.915800842158, 8526.78683032929], "value": 5818.376289901855, "unit": "score"}], "name": "dromaeo_css", "value": 6198.854445658883, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 131.0, 207.0, 138.0, 141.0, 151.0, 130.0, 163.0, 130.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 163.0, 161.0, 164.0, 162.0, 164.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 136.0, 76.0, 76.0, 84.0, 75.0, 129.0, 76.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 159.0, 93.0, 93.0, 94.0, 124.0, 93.0, 94.0, 130.0], "value": 106.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 67.0, 65.0, 64.0, 65.0, 63.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 83.0, 83.0, 83.0, 89.0, 84.0, 83.0, 148.0, 90.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 128.0, 130.0, 144.0, 134.0, 134.0, 137.0, 157.0, 133.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 173.0, 173.0, 169.0, 177.0, 169.0, 171.0, 173.0, 169.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 65.0, 70.0, 66.0, 69.0, 66.0, 65.0, 65.0, 64.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1573.3000000000002, "alertThreshold": 2.0}]} 11:57:58 INFO - Return code: 0 11:57:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:57:58 ERROR - # TBPL SUCCESS # 11:57:58 INFO - Running post-action listener: _resource_record_post_action 11:57:58 INFO - ##### 11:57:58 INFO - ##### Finished run-tests step (success) 11:57:58 INFO - ##### 11:57:58 INFO - Running post-run listener: _resource_record_post_run 11:57:58 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530452480; Read time: 12; Write time: 591396 11:57:58 INFO - TinderboxPrint: CPU usage
13.2% 11:57:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:57:58 INFO - TinderboxPrint: I/O write bytes / time
530,452,480 / 591,396 11:57:58 INFO - TinderboxPrint: CPU idle
8,321.2 (86.8%) 11:57:58 INFO - TinderboxPrint: CPU user
1,220.3 (12.7%) 11:57:58 INFO - TinderboxPrint: Swap in / out
0 / 0 11:57:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236797952; Read time: 0; Write time: 268624 11:57:58 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293363712; Read time: 12; Write time: 322744 11:57:59 INFO - Running post-run listener: _upload_blobber_files 11:57:59 INFO - Blob upload gear active. 11:57:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:57:59 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 11:57:59 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:57:59 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:57:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:58:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:04 INFO - (blobuploader) - INFO - Done attempting. 11:58:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:58:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:58:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:05 INFO - (blobuploader) - INFO - Done attempting. 11:58:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:58:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:13 INFO - (blobuploader) - INFO - Done attempting. 11:58:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:58:13 INFO - Return code: 0 11:58:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:58:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:58:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2b2a3648bd0b117eae36b3005dabbc00e3c5c684e61096850a5f7759ffd208a2493cf7f30224bd5097a57449a46a3d256894d6852cf89e9f810195aac510b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab2752896c20803fd2a65aa983f1fb975b8511e7d58d454a625d7812fa44deb7cf259bbfff6c9e4f8a923656493f8358e2efbdcd531d77f149cdcbd2960f41a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd9c5f57ec07fead5bb0f44399c655fe1b52e201d6d9222e09567c4aacc62e84917c1447ce8ebe83fc86232f8304190342b95be06ba91ac3d26b84b85921de9c"} 11:58:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:58:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:58:13 INFO - Contents: 11:58:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2b2a3648bd0b117eae36b3005dabbc00e3c5c684e61096850a5f7759ffd208a2493cf7f30224bd5097a57449a46a3d256894d6852cf89e9f810195aac510b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab2752896c20803fd2a65aa983f1fb975b8511e7d58d454a625d7812fa44deb7cf259bbfff6c9e4f8a923656493f8358e2efbdcd531d77f149cdcbd2960f41a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd9c5f57ec07fead5bb0f44399c655fe1b52e201d6d9222e09567c4aacc62e84917c1447ce8ebe83fc86232f8304190342b95be06ba91ac3d26b84b85921de9c"} 11:58:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:58:13 INFO - Copying logs to upload dir... 11:58:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:58:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.470295 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-23 11:58:12.514610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:58:12.518178) ========= 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=fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2b2a3648bd0b117eae36b3005dabbc00e3c5c684e61096850a5f7759ffd208a2493cf7f30224bd5097a57449a46a3d256894d6852cf89e9f810195aac510b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab2752896c20803fd2a65aa983f1fb975b8511e7d58d454a625d7812fa44deb7cf259bbfff6c9e4f8a923656493f8358e2efbdcd531d77f149cdcbd2960f41a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd9c5f57ec07fead5bb0f44399c655fe1b52e201d6d9222e09567c4aacc62e84917c1447ce8ebe83fc86232f8304190342b95be06ba91ac3d26b84b85921de9c"} build_url:https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/EGVDYE1TTdeeiAQyVDeVOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2b2a3648bd0b117eae36b3005dabbc00e3c5c684e61096850a5f7759ffd208a2493cf7f30224bd5097a57449a46a3d256894d6852cf89e9f810195aac510b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab2752896c20803fd2a65aa983f1fb975b8511e7d58d454a625d7812fa44deb7cf259bbfff6c9e4f8a923656493f8358e2efbdcd531d77f149cdcbd2960f41a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd9c5f57ec07fead5bb0f44399c655fe1b52e201d6d9222e09567c4aacc62e84917c1447ce8ebe83fc86232f8304190342b95be06ba91ac3d26b84b85921de9c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:58:12.543751) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:58:12.544103) ========= 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=fa44defc139c4ba8574fe040000001db-1464028639.943778-922746018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:58:12.626930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:58:12.627313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:58:12.627644) ========= ========= Total master_lag: 0.17 =========