builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1462695932.75 results: success (0) buildid: 20160508004657 builduid: a2f52d406a154f0fb05c90c5a75d9e4b revision: a3d59df2a8e356daae28128310db872d61c01f8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.753574) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.754047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.754576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.781488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.781851) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-08 01:25:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.6M=0.001s 2016-05-08 01:25:33 (21.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.931266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.931600) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016447 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.984883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:32.985356) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3d59df2a8e356daae28128310db872d61c01f8f --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 a3d59df2a8e356daae28128310db872d61c01f8f --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=4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-08 01:25:33,288 truncating revision to first 12 chars 2016-05-08 01:25:33,288 Setting DEBUG logging. 2016-05-08 01:25:33,288 attempt 1/10 2016-05-08 01:25:33,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3d59df2a8e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-08 01:25:33,567 unpacking tar archive at: fx-team-a3d59df2a8e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587310 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:33.585635) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:33.585950) ========= script_repo_revision: a3d59df2a8e356daae28128310db872d61c01f8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:33.586374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:33.586692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 01:25:33.598962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-08 01:25:33.599290) ========= /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=4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:25:33 INFO - MultiFileLogger online at 20160508 01:25:33 in /builds/slave/test 01:25:33 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 01:25:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:33 INFO - {'append_to_log': False, 01:25:33 INFO - 'base_work_dir': '/builds/slave/test', 01:25:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:25:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:33 INFO - 'branch': 'Fx-Team-Non-PGO', 01:25:33 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:33 INFO - 'config_files': ('talos/linux_config.py',), 01:25:33 INFO - 'default_actions': ('clobber', 01:25:33 INFO - 'read-buildbot-config', 01:25:33 INFO - 'download-and-extract', 01:25:33 INFO - 'populate-webroot', 01:25:33 INFO - 'create-virtualenv', 01:25:33 INFO - 'install', 01:25:33 INFO - 'run-tests'), 01:25:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:33 INFO - 'download_minidump_stackwalk': True, 01:25:33 INFO - 'download_symbols': 'ondemand', 01:25:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:33 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:33 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:33 INFO - 'installer_path': 'installer.exe', 01:25:33 INFO - 'log_level': 'info', 01:25:33 INFO - 'log_name': 'talos', 01:25:33 INFO - 'log_to_console': True, 01:25:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:25:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:25:33 INFO - 'opt_config_files': (), 01:25:33 INFO - 'pip_index': False, 01:25:33 INFO - 'sps_profile': False, 01:25:33 INFO - 'sps_profile_interval': 0, 01:25:33 INFO - 'suite': 'dromaeojs', 01:25:33 INFO - 'system_bits': '32', 01:25:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:33 INFO - 'title': 'talos-linux64-ix-030', 01:25:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:33 INFO - 'use_talos_json': True, 01:25:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:33 INFO - 'work_dir': 'build'} 01:25:33 INFO - ##### 01:25:33 INFO - ##### Running clobber step. 01:25:33 INFO - ##### 01:25:33 INFO - Running pre-action listener: _resource_record_pre_action 01:25:33 INFO - Running main action method: clobber 01:25:33 INFO - rmtree: /builds/slave/test/build 01:25:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:34 INFO - Running post-action listener: _resource_record_post_action 01:25:34 INFO - ##### 01:25:34 INFO - ##### Finished clobber step (success) 01:25:34 INFO - ##### 01:25:34 INFO - ##### 01:25:34 INFO - ##### Running read-buildbot-config step. 01:25:34 INFO - ##### 01:25:34 INFO - Running pre-action listener: _resource_record_pre_action 01:25:34 INFO - Running main action method: read_buildbot_config 01:25:34 INFO - Using buildbot properties: 01:25:34 INFO - { 01:25:34 INFO - "project": "", 01:25:34 INFO - "product": "firefox", 01:25:34 INFO - "script_repo_revision": "production", 01:25:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:25:34 INFO - "repository": "", 01:25:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:25:34 INFO - "buildid": "20160508004657", 01:25:34 INFO - "pgo_build": "False", 01:25:34 INFO - "basedir": "/builds/slave/test", 01:25:34 INFO - "buildnumber": 1668, 01:25:34 INFO - "slavename": "talos-linux64-ix-030", 01:25:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:25:34 INFO - "platform": "ubuntu64_hw", 01:25:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:25:34 INFO - "branch": "fx-team", 01:25:34 INFO - "repo_path": "integration/fx-team", 01:25:34 INFO - "revision": "a3d59df2a8e356daae28128310db872d61c01f8f", 01:25:34 INFO - "stage_platform": "linux64", 01:25:34 INFO - "builduid": "a2f52d406a154f0fb05c90c5a75d9e4b", 01:25:34 INFO - "slavebuilddir": "test" 01:25:34 INFO - } 01:25:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:25:34 INFO - Running post-action listener: _resource_record_post_action 01:25:34 INFO - ##### 01:25:34 INFO - ##### Finished read-buildbot-config step (success) 01:25:34 INFO - ##### 01:25:34 INFO - ##### 01:25:34 INFO - ##### Running download-and-extract step. 01:25:34 INFO - ##### 01:25:34 INFO - Running pre-action listener: _resource_record_pre_action 01:25:34 INFO - Running main action method: download_and_extract 01:25:34 INFO - mkdir: /builds/slave/test/build/tests 01:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:34 INFO - https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:25:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:25:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:25:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:25:36 INFO - Downloaded 1361 bytes. 01:25:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:25:36 INFO - Using the following test package requirements: 01:25:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:25:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:25:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:36 INFO - u'jsshell-linux-x86_64.zip'], 01:25:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:25:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:25:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:25:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:25:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:25:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:36 INFO - https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:38 INFO - Downloaded 22321369 bytes. 01:25:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:25:39 INFO - Return code: 0 01:25:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:39 INFO - https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:40 INFO - Downloaded 22321369 bytes. 01:25:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:25:42 INFO - Return code: 0 01:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:42 INFO - https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:25:43 INFO - Downloaded 10840152 bytes. 01:25:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:25:43 INFO - Return code: 0 01:25: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')]} 01:25:43 INFO - https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:25:45 INFO - Downloaded 54842920 bytes. 01:25:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:45 INFO - mkdir: /builds/slave/test/properties 01:25:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:45 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:45 INFO - Contents: 01:25:45 INFO - build_url:https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:46 INFO - Running post-action listener: _resource_record_post_action 01:25:46 INFO - Running post-action listener: set_extra_try_arguments 01:25:46 INFO - ##### 01:25:46 INFO - ##### Finished download-and-extract step (success) 01:25:46 INFO - ##### 01:25:46 INFO - ##### 01:25:46 INFO - ##### Running populate-webroot step. 01:25:46 INFO - ##### 01:25:46 INFO - Running pre-action listener: _resource_record_pre_action 01:25:46 INFO - Running main action method: populate_webroot 01:25:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:46 INFO - '--tppagecycles', 01:25:46 INFO - '7'], 01:25:46 INFO - 'tests': ['tsvgm']}}, 01:25:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:46 INFO - 'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:46 INFO - 'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['damp', 'tps']}, 01:25:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:46 INFO - 'tests': ['damp', 'tps']}, 01:25:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['dromaeo_dom']}, 01:25:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['a11yr', 01:25:46 INFO - 'ts_paint', 01:25:46 INFO - 'tpaint', 01:25:46 INFO - 'sessionrestore', 01:25:46 INFO - 'sessionrestore_no_auto_restore', 01:25:46 INFO - 'tabpaint']}, 01:25:46 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:46 INFO - 'ts_paint', 01:25:46 INFO - 'tpaint', 01:25:46 INFO - 'sessionrestore', 01:25:46 INFO - 'sessionrestore_no_auto_restore', 01:25:46 INFO - 'tabpaint']}, 01:25:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:46 INFO - 'ts_paint', 01:25:46 INFO - 'tpaint', 01:25:46 INFO - 'sessionrestore', 01:25:46 INFO - 'sessionrestore_no_auto_restore', 01:25:46 INFO - 'tabpaint']}, 01:25:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:46 INFO - 'ts_paint', 01:25:46 INFO - 'tpaint', 01:25:46 INFO - 'sessionrestore', 01:25:46 INFO - 'sessionrestore_no_auto_restore', 01:25:46 INFO - 'tabpaint']}, 01:25:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['a11yr', 01:25:46 INFO - 'ts_paint', 01:25:46 INFO - 'tpaint', 01:25:46 INFO - 'sessionrestore', 01:25:46 INFO - 'sessionrestore_no_auto_restore', 01:25:46 INFO - 'tabpaint']}, 01:25:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['a11yr', 01:25:46 INFO - 'ts_paint', 01:25:46 INFO - 'tpaint', 01:25:46 INFO - 'sessionrestore', 01:25:46 INFO - 'sessionrestore_no_auto_restore', 01:25:46 INFO - 'tabpaint']}, 01:25:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['tsvgx', 01:25:46 INFO - 'tsvgr_opacity', 01:25:46 INFO - 'tart', 01:25:46 INFO - 'tscrollx', 01:25:46 INFO - 'cart']}, 01:25:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:46 INFO - 'tsvgr_opacity', 01:25:46 INFO - 'tart', 01:25:46 INFO - 'tscrollx', 01:25:46 INFO - 'cart']}, 01:25:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:46 INFO - 'talos_options': ['--disable-e10s'], 01:25:46 INFO - 'tests': ['tp5o']}, 01:25:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:46 INFO - 'tests': ['tp5o']}, 01:25:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:46 INFO - 'talos_options': ['--disable-e10s', 01:25:46 INFO - '--xperf_path', 01:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:46 INFO - 'tests': ['tp5n']}, 01:25:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:46 INFO - 'talos_options': ['--xperf_path', 01:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:46 INFO - 'tests': ['tp5n']}}, 01:25:46 INFO - 'talos.zip': {'path': '', 01:25:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:46 INFO - Running post-action listener: _resource_record_post_action 01:25:46 INFO - ##### 01:25:46 INFO - ##### Finished populate-webroot step (success) 01:25:46 INFO - ##### 01:25:46 INFO - ##### 01:25:46 INFO - ##### Running create-virtualenv step. 01:25:46 INFO - ##### 01:25:46 INFO - Running pre-action listener: _resource_record_pre_action 01:25:46 INFO - Running main action method: create_virtualenv 01:25:46 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:25:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:46 INFO - Using real prefix '/usr' 01:25:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:25:48 INFO - Installing pip.................done. 01:25:48 INFO - Return code: 0 01:25:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:25:48 INFO - Using env: {'DISPLAY': ':0', 01:25:48 INFO - 'HOME': '/home/cltbld', 01:25:48 INFO - 'LANG': 'en_US.UTF-8', 01:25:48 INFO - 'LANGUAGE': 'en_US:en', 01:25:48 INFO - 'LOGNAME': 'cltbld', 01:25:48 INFO - 'MAIL': '/var/mail/cltbld', 01:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:48 INFO - 'MOZ_NO_REMOTE': '1', 01:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:48 INFO - 'NO_EM_RESTART': '1', 01:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:48 INFO - 'PWD': '/builds/slave/test', 01:25:48 INFO - 'SHELL': '/bin/bash', 01:25:48 INFO - 'SHLVL': '1', 01:25:48 INFO - 'TERM': 'linux', 01:25:48 INFO - 'TMOUT': '86400', 01:25:48 INFO - 'USER': 'cltbld', 01:25:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:48 INFO - '_': '/tools/buildbot/bin/python'} 01:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:25:48 INFO - Cleaning up... 01:25:48 INFO - Return code: 0 01:25:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:25:48 INFO - Using env: {'DISPLAY': ':0', 01:25:48 INFO - 'HOME': '/home/cltbld', 01:25:48 INFO - 'LANG': 'en_US.UTF-8', 01:25:48 INFO - 'LANGUAGE': 'en_US:en', 01:25:48 INFO - 'LOGNAME': 'cltbld', 01:25:48 INFO - 'MAIL': '/var/mail/cltbld', 01:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:48 INFO - 'MOZ_NO_REMOTE': '1', 01:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:48 INFO - 'NO_EM_RESTART': '1', 01:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:48 INFO - 'PWD': '/builds/slave/test', 01:25:48 INFO - 'SHELL': '/bin/bash', 01:25:48 INFO - 'SHLVL': '1', 01:25:48 INFO - 'TERM': 'linux', 01:25:48 INFO - 'TMOUT': '86400', 01:25:48 INFO - 'USER': 'cltbld', 01:25:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:48 INFO - '_': '/tools/buildbot/bin/python'} 01:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:49 INFO - Downloading/unpacking psutil>=0.7.1 01:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:51 INFO - Installing collected packages: psutil 01:25:51 INFO - Running setup.py install for psutil 01:25:51 INFO - building 'psutil._psutil_linux' extension 01:25:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:25:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:25:51 INFO - building 'psutil._psutil_posix' extension 01:25:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:25:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:51 INFO - Successfully installed psutil 01:25:51 INFO - Cleaning up... 01:25:51 INFO - Return code: 0 01:25:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:25:51 INFO - Using env: {'DISPLAY': ':0', 01:25:51 INFO - 'HOME': '/home/cltbld', 01:25:51 INFO - 'LANG': 'en_US.UTF-8', 01:25:51 INFO - 'LANGUAGE': 'en_US:en', 01:25:51 INFO - 'LOGNAME': 'cltbld', 01:25:51 INFO - 'MAIL': '/var/mail/cltbld', 01:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:51 INFO - 'MOZ_NO_REMOTE': '1', 01:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:51 INFO - 'NO_EM_RESTART': '1', 01:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:51 INFO - 'PWD': '/builds/slave/test', 01:25:51 INFO - 'SHELL': '/bin/bash', 01:25:51 INFO - 'SHLVL': '1', 01:25:51 INFO - 'TERM': 'linux', 01:25:51 INFO - 'TMOUT': '86400', 01:25:51 INFO - 'USER': 'cltbld', 01:25:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:51 INFO - '_': '/tools/buildbot/bin/python'} 01:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:25:53 INFO - Installing collected packages: mozsystemmonitor 01:25:53 INFO - Running setup.py install for mozsystemmonitor 01:25:53 INFO - Successfully installed mozsystemmonitor 01:25:53 INFO - Cleaning up... 01:25:53 INFO - Return code: 0 01:25:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:25:53 INFO - Using env: {'DISPLAY': ':0', 01:25:53 INFO - 'HOME': '/home/cltbld', 01:25:53 INFO - 'LANG': 'en_US.UTF-8', 01:25:53 INFO - 'LANGUAGE': 'en_US:en', 01:25:53 INFO - 'LOGNAME': 'cltbld', 01:25:53 INFO - 'MAIL': '/var/mail/cltbld', 01:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:53 INFO - 'MOZ_NO_REMOTE': '1', 01:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:53 INFO - 'NO_EM_RESTART': '1', 01:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:53 INFO - 'PWD': '/builds/slave/test', 01:25:53 INFO - 'SHELL': '/bin/bash', 01:25:53 INFO - 'SHLVL': '1', 01:25:53 INFO - 'TERM': 'linux', 01:25:53 INFO - 'TMOUT': '86400', 01:25:53 INFO - 'USER': 'cltbld', 01:25:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:53 INFO - '_': '/tools/buildbot/bin/python'} 01:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:54 INFO - Downloading/unpacking blobuploader==1.2.4 01:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:55 INFO - Downloading blobuploader-1.2.4.tar.gz 01:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:25:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:25:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:56 INFO - Downloading docopt-0.6.1.tar.gz 01:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:25:56 INFO - Installing collected packages: blobuploader, requests, docopt 01:25:56 INFO - Running setup.py install for blobuploader 01:25:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:25:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:25:56 INFO - Running setup.py install for requests 01:25:57 INFO - Running setup.py install for docopt 01:25:57 INFO - Successfully installed blobuploader requests docopt 01:25:57 INFO - Cleaning up... 01:25:57 INFO - Return code: 0 01:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:25:57 INFO - Using env: {'DISPLAY': ':0', 01:25:57 INFO - 'HOME': '/home/cltbld', 01:25:57 INFO - 'LANG': 'en_US.UTF-8', 01:25:57 INFO - 'LANGUAGE': 'en_US:en', 01:25:57 INFO - 'LOGNAME': 'cltbld', 01:25:57 INFO - 'MAIL': '/var/mail/cltbld', 01:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:57 INFO - 'MOZ_NO_REMOTE': '1', 01:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:57 INFO - 'NO_EM_RESTART': '1', 01:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:57 INFO - 'PWD': '/builds/slave/test', 01:25:57 INFO - 'SHELL': '/bin/bash', 01:25:57 INFO - 'SHLVL': '1', 01:25:57 INFO - 'TERM': 'linux', 01:25:57 INFO - 'TMOUT': '86400', 01:25:57 INFO - 'USER': 'cltbld', 01:25:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:57 INFO - '_': '/tools/buildbot/bin/python'} 01:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:57 INFO - Running setup.py (path:/tmp/pip-9VjsPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:57 INFO - Running setup.py (path:/tmp/pip-QfIJyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:57 INFO - Running setup.py (path:/tmp/pip-GFPtbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:57 INFO - Running setup.py (path:/tmp/pip-mKXhl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:57 INFO - Running setup.py (path:/tmp/pip-0f_mkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:57 INFO - Running setup.py (path:/tmp/pip-rJBsYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:57 INFO - Running setup.py (path:/tmp/pip-P8NpUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:58 INFO - Running setup.py (path:/tmp/pip-DsDFob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:58 INFO - Running setup.py (path:/tmp/pip-ZffOKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:58 INFO - Running setup.py (path:/tmp/pip-yoWhe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:58 INFO - Running setup.py (path:/tmp/pip-K0SW0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:58 INFO - Running setup.py (path:/tmp/pip-EwP45U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:58 INFO - Running setup.py (path:/tmp/pip-07ftSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:58 INFO - Running setup.py (path:/tmp/pip-6R0sml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:58 INFO - Running setup.py (path:/tmp/pip-dugaCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:58 INFO - Running setup.py (path:/tmp/pip-0HEBvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:58 INFO - Running setup.py (path:/tmp/pip-TNzrSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:25:58 INFO - Running setup.py install for manifestparser 01:25:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:25:58 INFO - Running setup.py install for mozcrash 01:25:58 INFO - Running setup.py install for mozdebug 01:25:59 INFO - Running setup.py install for mozdevice 01:25:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Running setup.py install for mozfile 01:25:59 INFO - Running setup.py install for mozhttpd 01:25:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Running setup.py install for mozinfo 01:25:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Running setup.py install for mozInstall 01:25:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Running setup.py install for mozleak 01:25:59 INFO - Running setup.py install for mozlog 01:25:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Running setup.py install for moznetwork 01:25:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:59 INFO - Running setup.py install for mozprocess 01:25:59 INFO - Running setup.py install for mozprofile 01:26:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:26:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:26:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:26:00 INFO - Running setup.py install for mozrunner 01:26:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:26:00 INFO - Running setup.py install for mozscreenshot 01:26:00 INFO - Running setup.py install for moztest 01:26:00 INFO - Running setup.py install for mozversion 01:26:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:26:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:00 INFO - Cleaning up... 01:26:00 INFO - Return code: 0 01:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:26:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:26:00 INFO - Using env: {'DISPLAY': ':0', 01:26:00 INFO - 'HOME': '/home/cltbld', 01:26:00 INFO - 'LANG': 'en_US.UTF-8', 01:26:00 INFO - 'LANGUAGE': 'en_US:en', 01:26:00 INFO - 'LOGNAME': 'cltbld', 01:26:00 INFO - 'MAIL': '/var/mail/cltbld', 01:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:00 INFO - 'MOZ_NO_REMOTE': '1', 01:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:00 INFO - 'NO_EM_RESTART': '1', 01:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:00 INFO - 'PWD': '/builds/slave/test', 01:26:00 INFO - 'SHELL': '/bin/bash', 01:26:00 INFO - 'SHLVL': '1', 01:26:00 INFO - 'TERM': 'linux', 01:26:00 INFO - 'TMOUT': '86400', 01:26:00 INFO - 'USER': 'cltbld', 01:26:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:00 INFO - '_': '/tools/buildbot/bin/python'} 01:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:00 INFO - Running setup.py (path:/tmp/pip-xCrFcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:00 INFO - Running setup.py (path:/tmp/pip-mILRKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:00 INFO - Running setup.py (path:/tmp/pip-oHzjzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:00 INFO - Running setup.py (path:/tmp/pip-NEM_KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:01 INFO - Running setup.py (path:/tmp/pip-ICfIDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:01 INFO - Running setup.py (path:/tmp/pip-efWhvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:01 INFO - Running setup.py (path:/tmp/pip-gRg6Dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:01 INFO - Running setup.py (path:/tmp/pip-LGBknZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:01 INFO - Running setup.py (path:/tmp/pip-CUpYVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:01 INFO - Running setup.py (path:/tmp/pip-WXUh0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:01 INFO - Running setup.py (path:/tmp/pip-f_Mhdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:01 INFO - Running setup.py (path:/tmp/pip-hjxaaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:01 INFO - Running setup.py (path:/tmp/pip-43IEjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:01 INFO - Running setup.py (path:/tmp/pip-DMn96E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:01 INFO - Running setup.py (path:/tmp/pip-PuwAYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:01 INFO - Running setup.py (path:/tmp/pip-QBSzg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:01 INFO - Running setup.py (path:/tmp/pip-1HzdEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:26:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:03 INFO - Downloading blessings-1.6.tar.gz 01:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:03 INFO - Installing collected packages: blessings 01:26:03 INFO - Running setup.py install for blessings 01:26:04 INFO - Successfully installed blessings 01:26:04 INFO - Cleaning up... 01:26:04 INFO - Return code: 0 01:26:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:04 INFO - Reading from file tmpfile_stdout 01:26:04 INFO - Current package versions: 01:26:04 INFO - argparse == 1.2.1 01:26:04 INFO - blessings == 1.6 01:26:04 INFO - blobuploader == 1.2.4 01:26:04 INFO - docopt == 0.6.1 01:26:04 INFO - manifestparser == 1.1 01:26:04 INFO - mozInstall == 1.12 01:26:04 INFO - mozcrash == 0.17 01:26:04 INFO - mozdebug == 0.1 01:26:04 INFO - mozdevice == 0.48 01:26:04 INFO - mozfile == 1.2 01:26:04 INFO - mozhttpd == 0.7 01:26:04 INFO - mozinfo == 0.9 01:26:04 INFO - mozleak == 0.1 01:26:04 INFO - mozlog == 3.1 01:26:04 INFO - moznetwork == 0.27 01:26:04 INFO - mozprocess == 0.22 01:26:04 INFO - mozprofile == 0.28 01:26:04 INFO - mozrunner == 6.11 01:26:04 INFO - mozscreenshot == 0.1 01:26:04 INFO - mozsystemmonitor == 0.0 01:26:04 INFO - moztest == 0.7 01:26:04 INFO - mozversion == 1.4 01:26:04 INFO - psutil == 3.1.1 01:26:04 INFO - requests == 1.2.3 01:26:04 INFO - wsgiref == 0.1.2 01:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:26:04 INFO - Using env: {'DISPLAY': ':0', 01:26:04 INFO - 'HOME': '/home/cltbld', 01:26:04 INFO - 'LANG': 'en_US.UTF-8', 01:26:04 INFO - 'LANGUAGE': 'en_US:en', 01:26:04 INFO - 'LOGNAME': 'cltbld', 01:26:04 INFO - 'MAIL': '/var/mail/cltbld', 01:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:04 INFO - 'MOZ_NO_REMOTE': '1', 01:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:04 INFO - 'NO_EM_RESTART': '1', 01:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:04 INFO - 'PWD': '/builds/slave/test', 01:26:04 INFO - 'SHELL': '/bin/bash', 01:26:04 INFO - 'SHLVL': '1', 01:26:04 INFO - 'TERM': 'linux', 01:26:04 INFO - 'TMOUT': '86400', 01:26:04 INFO - 'USER': 'cltbld', 01:26:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:04 INFO - '_': '/tools/buildbot/bin/python'} 01:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:26:04 INFO - Cleaning up... 01:26:04 INFO - Return code: 0 01:26:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:26:04 INFO - Using env: {'DISPLAY': ':0', 01:26:04 INFO - 'HOME': '/home/cltbld', 01:26:04 INFO - 'LANG': 'en_US.UTF-8', 01:26:04 INFO - 'LANGUAGE': 'en_US:en', 01:26:04 INFO - 'LOGNAME': 'cltbld', 01:26:04 INFO - 'MAIL': '/var/mail/cltbld', 01:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:04 INFO - 'MOZ_NO_REMOTE': '1', 01:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:04 INFO - 'NO_EM_RESTART': '1', 01:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:04 INFO - 'PWD': '/builds/slave/test', 01:26:04 INFO - 'SHELL': '/bin/bash', 01:26:04 INFO - 'SHLVL': '1', 01:26:04 INFO - 'TERM': 'linux', 01:26:04 INFO - 'TMOUT': '86400', 01:26:04 INFO - 'USER': 'cltbld', 01:26:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:04 INFO - '_': '/tools/buildbot/bin/python'} 01:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:04 INFO - Downloading/unpacking jsonschema 01:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:06 INFO - Downloading/unpacking functools32 (from jsonschema) 01:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:06 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:06 INFO - warning: no files found matching '*.txt' 01:26:06 INFO - no previously-included directories found matching 'build' 01:26:06 INFO - no previously-included directories found matching 'dist' 01:26:06 INFO - no previously-included directories found matching '.git*' 01:26:06 INFO - Installing collected packages: jsonschema, functools32 01:26:06 INFO - Running setup.py install for functools32 01:26:07 INFO - warning: no files found matching '*.txt' 01:26:07 INFO - no previously-included directories found matching 'build' 01:26:07 INFO - no previously-included directories found matching 'dist' 01:26:07 INFO - no previously-included directories found matching '.git*' 01:26:07 INFO - Successfully installed jsonschema functools32 01:26:07 INFO - Cleaning up... 01:26:07 INFO - Return code: 0 01:26:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb22cdbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, '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': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:26:07 INFO - Using env: {'DISPLAY': ':0', 01:26:07 INFO - 'HOME': '/home/cltbld', 01:26:07 INFO - 'LANG': 'en_US.UTF-8', 01:26:07 INFO - 'LANGUAGE': 'en_US:en', 01:26:07 INFO - 'LOGNAME': 'cltbld', 01:26:07 INFO - 'MAIL': '/var/mail/cltbld', 01:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:07 INFO - 'MOZ_NO_REMOTE': '1', 01:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:07 INFO - 'NO_EM_RESTART': '1', 01:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:07 INFO - 'PWD': '/builds/slave/test', 01:26:07 INFO - 'SHELL': '/bin/bash', 01:26:07 INFO - 'SHLVL': '1', 01:26:07 INFO - 'TERM': 'linux', 01:26:07 INFO - 'TMOUT': '86400', 01:26:07 INFO - 'USER': 'cltbld', 01:26:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:07 INFO - '_': '/tools/buildbot/bin/python'} 01:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:07 INFO - Downloading/unpacking flake8 01:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:26:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:26:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:26:09 INFO - no previously-included directories found matching 'docs/_build' 01:26:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:26:10 INFO - Running setup.py install for pep8 01:26:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:26:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:26:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:26:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:26:10 INFO - no previously-included directories found matching 'docs/_build' 01:26:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:26:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:26:10 INFO - Cleaning up... 01:26:10 INFO - Return code: 0 01:26:10 INFO - Running post-action listener: _resource_record_post_action 01:26:10 INFO - Running post-action listener: _start_resource_monitoring 01:26:10 INFO - Starting resource monitoring. 01:26:10 INFO - ##### 01:26:10 INFO - ##### Finished create-virtualenv step (success) 01:26:10 INFO - ##### 01:26:10 INFO - ##### 01:26:10 INFO - ##### Running install step. 01:26:10 INFO - ##### 01:26:10 INFO - Running pre-action listener: _resource_record_pre_action 01:26:10 INFO - Running main action method: install 01:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:10 INFO - Reading from file tmpfile_stdout 01:26:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:26:10 INFO - Reading from file tmpfile_stdout 01:26:10 INFO - Output received: 01:26:10 INFO - Usage: mozinstall [options] installer 01:26:10 INFO - Options: 01:26:10 INFO - -h, --help show this help message and exit 01:26:10 INFO - -d DEST, --destination=DEST 01:26:10 INFO - Directory to install application into. [default: 01:26:10 INFO - "/builds/slave/test"] 01:26:10 INFO - --app=APP Application being installed. [default: firefox] 01:26:10 INFO - mkdir: /builds/slave/test/build/application 01:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:26:26 INFO - Reading from file tmpfile_stdout 01:26:26 INFO - Output received: 01:26:26 INFO - /builds/slave/test/build/application/firefox/firefox 01:26:26 INFO - Running post-action listener: _resource_record_post_action 01:26:26 INFO - ##### 01:26:26 INFO - ##### Finished install step (success) 01:26:26 INFO - ##### 01:26:26 INFO - ##### 01:26:26 INFO - ##### Running run-tests step. 01:26:26 INFO - ##### 01:26:26 INFO - Running pre-action listener: _resource_record_pre_action 01:26:26 INFO - Running main action method: run_tests 01:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:26:26 INFO - Python 2.7.3 01:26:26 INFO - Return code: 0 01:26:26 INFO - grabbing minidump binary from tooltool 01:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24699c0>, '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 0x246a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:26:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:26:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:26:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:26:26 INFO - Return code: 0 01:26:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:26:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:26:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:26:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:26:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:26:27 INFO - Return code: 0 01:26:27 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/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 01:26:27 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/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 01:26:27 INFO - Using env: {'DISPLAY': ':0', 01:26:27 INFO - 'HOME': '/home/cltbld', 01:26:27 INFO - 'LANG': 'en_US.UTF-8', 01:26:27 INFO - 'LANGUAGE': 'en_US:en', 01:26:27 INFO - 'LOGNAME': 'cltbld', 01:26:27 INFO - 'MAIL': '/var/mail/cltbld', 01:26:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:26:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:27 INFO - 'MOZ_NO_REMOTE': '1', 01:26:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:27 INFO - 'NO_EM_RESTART': '1', 01:26:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:27 INFO - 'PWD': '/builds/slave/test', 01:26:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:26:27 INFO - 'SHELL': '/bin/bash', 01:26:27 INFO - 'SHLVL': '1', 01:26:27 INFO - 'TERM': 'linux', 01:26:27 INFO - 'TMOUT': '86400', 01:26:27 INFO - 'USER': 'cltbld', 01:26:27 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078', 01:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:27 INFO - '_': '/tools/buildbot/bin/python'} 01:26:27 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/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 01:26:27 INFO - mozversion application_buildid: 20160508004657 01:26:27 INFO - mozversion application_changeset: a3d59df2a8e356daae28128310db872d61c01f8f 01:26:27 INFO - mozversion application_display_name: Nightly 01:26:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:26:27 INFO - mozversion application_name: Firefox 01:26:27 INFO - mozversion application_remotingname: firefox 01:26:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:26:27 INFO - mozversion application_vendor: Mozilla 01:26:27 INFO - mozversion application_version: 49.0a1 01:26:27 INFO - mozversion platform_buildid: 20160508004657 01:26:27 INFO - mozversion platform_changeset: a3d59df2a8e356daae28128310db872d61c01f8f 01:26:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:26:27 INFO - mozversion platform_version: 49.0a1 01:26:27 INFO - using testdate: 1462695987 01:26:27 INFO - actual date: 1462695987 01:26:27 INFO - starting webserver on 'localhost:52803' 01:26:27 INFO - SUITE-START | Running 2 tests 01:26:27 INFO - TEST-START | dromaeo_css 01:26:27 INFO - operating with platform_type : linux_ 01:26:27 INFO - Initialising browser for dromaeo_css test... 01:26:27 INFO - TEST-INFO | started process 17828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8v2GGe/profile http://localhost:52803/getInfo.html) 01:26:31 INFO - PROCESS | 17828 | __metrics Screen width/height:1600/1200 01:26:31 INFO - PROCESS | 17828 | colorDepth:24 01:26:31 INFO - PROCESS | 17828 | Browser inner width/height: 1024/697 01:26:31 INFO - PROCESS | 17828 | __metrics 01:26:32 ERROR - PROCESS | 17828 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:26:33 INFO - TEST-INFO | 17828: exit 0 01:26:33 INFO - Browser initialized. 01:26:33 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:33 INFO - TEST-INFO | started process 17908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8v2GGe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:45 INFO - PROCESS | 17908 | RSS: Main: 153489408 01:26:45 INFO - PROCESS | 17908 | 01:27:36 INFO - PROCESS | 17908 | 1462696056572 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] 01:29:47 INFO - PROCESS | 17908 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52803/tests/dromaeo/cssquery-ext.html) 01:29:48 INFO - PROCESS | 17908 | RSS: Main: 234749952 01:29:48 INFO - PROCESS | 17908 | 01:32:51 INFO - PROCESS | 17908 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-ext.html (next: http://localhost:52803/tests/dromaeo/cssquery-jquery.html) 01:32:52 INFO - PROCESS | 17908 | RSS: Main: 241131520 01:32:52 INFO - PROCESS | 17908 | 01:35:54 INFO - PROCESS | 17908 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52803/tests/dromaeo/cssquery-mootools.html) 01:35:54 INFO - PROCESS | 17908 | RSS: Main: 242188288 01:35:54 INFO - PROCESS | 17908 | 01:38:56 INFO - PROCESS | 17908 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52803/tests/dromaeo/cssquery-prototype.html) 01:38:57 INFO - PROCESS | 17908 | RSS: Main: 241901568 01:38:57 INFO - PROCESS | 17908 | 01:42:00 INFO - PROCESS | 17908 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52803/tests/dromaeo/cssquery-yui.html) 01:42:01 INFO - PROCESS | 17908 | RSS: Main: 206356480 01:42:01 INFO - PROCESS | 17908 | 01:45:03 INFO - PROCESS | 17908 | Cycle 1(1): loaded http://localhost:52803/tests/dromaeo/cssquery-yui.html (next: http://localhost:52803/tests/dromaeo/cssquery-dojo.html) 01:45:04 INFO - PROCESS | 17908 | RSS: Main: 274665472 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - PROCESS | 17908 | __start_tp_report 01:45:04 INFO - PROCESS | 17908 | _x_x_mozilla_page_load 01:45:04 INFO - PROCESS | 17908 | _x_x_mozilla_page_load_details 01:45:04 INFO - PROCESS | 17908 | |i|pagename|runs| 01:45:04 INFO - PROCESS | 17908 | |0;dojo.html;2577.201067669024;2595.5068536977974;2620.5283049051177;2620.7117217106115;2627.671541057368;4514.548545145484;4548.613367863732;4550.658700597456;4585.4038974933255;4590.036092420587;4519.932201016987;4531.592156705896;4564.475085365184;4613.354130421743;4625.722456652603;4155.916881662365;4201.3697945308295;4233.23801715691;4259.87220383389;4384.232759267132;4330.653547716175;4352.521222665504;4357;4364.694471386988;4403.383526306304;4151.5640857709805;4203.033302340479;4205;4231.196072746184;4267.338562522814;4257.020885196392;4265.7440553566885;4268.466441694788;4311.310190369557;4356.695031347807;4286.849960251377;4291.334843099325;4296.419983302246;4307.978460107711;4345.174416860818;4325.134973005412;4387.714798538085;4424.867253982386;4565.360849481042;4606.216943119644;4784.067106914154;4868.853934381974;4869.634777391674;4870.342503761982;4871.634627402959;4843.782029808632;4847.878803029953;4858.368412106439;4894.070126675921;4896.216605343128;4472.195004899149;4564.7717614119165;4572.611328037087;4611.146937816515;4618.907621847544;5041.773120209599;5062.519060689228;5071.721055341918;5090.567301779391;5103.055934652027;4757.238841785298;4758.690685105457;4789.976050119727;4795.496472870298;4804;4764.761761911891;4777.140114779373;4813.687110337887;4835.468098509161;4875.780589873464;4769.9046019080115;4788.592969597623;4797.232442809134;4830.154722923475;4848.636352273594;4794.065157294364;4794.856154315376;4797.808087676523;4806.855794326176;4845.781939812717;4102.589741025933;4137.40007698882;4142.502899652061;4150.06623509714;4190.769507677107;3704.9629503705155;3704.9629503705155;3710.239400922804;3711.536057992751;3712.331780279522;4166.020985068507;4178.310578754472;4213;4218.704690671623;4221.176870510221;4828.203346447796;4861.1006963711825;4867.221244600847;4871.391076115486;4921.237208232729;4197.24449599069;4197.244495990751;4200.537940826506;4235.512916014698;4240.109576988867;4329.545397733255;4350.108227813291;4365.9126817463475;4406.27296496081;4407.757573333433;4575.519570445055;4577.5880170784785;4584.61030812378;4590.311453282035;4622.791974361095;4783.210770222874;4829.710217386968;4832.395950506187;4838.129136755418;4868.634852386014;4547.590716835501;4571.634269258385;4579.908401832011;4591.47198072226;4614.307853821953;4822.180229360947;4823.807047718193;4825.734584597881;4825.782839772149;4850.393700787402;4877.463479017376;4884.609231261419;4886.755662216804;4888.095702295087;4939.6542242042715;4590.609798167193;4686.062787442457;4714.717116972993;4735.881602959954;4751.809927602995;4719.905601888012;4727.527247275245;4749.026449577897;4753.809847606057;4803.303520989507;4583.197940360357;4687.437507499122;4701.059788042337;4747.572718455355;4750.572448479654;4726.078414709099;4801.95198048015;4802.495737947465;4803.95196048049;4809.807607695653;4621.098885717252;4643.094596553775;4644.164050470948;4648.930266045944;4694.694844835075 01:45:04 INFO - PROCESS | 17908 | |1;ext.html;602.581206061787;609.7348002893996;617.4566381584206;629.9275583307918;634.8698516804055;42080;43266.351004734955;43313.35029974549;47514.28728569074;47580.99999999991;42672.35991460131;43115.35326970098;43131;43147.35278970818;43150.7842460788;7887.211278872095;7961.96019019907;7983.281504664579;8015.1984801519675;8023.638936247883;7848.6860525579195;7928.246816552418;7931.524108553505;7931.722389716361;7933.167017463141;7924;7952.4830885992515;7953.761387158365;7980.321672657831;7990.680372785082;7933.365330773524;7969.242921922408;7972.123066462714;7976.082750483711;7976.6809327626825;7876.921230787733;7948.046234451903;7949.64226609804;7954.562499062549;7954.9204507954755;39643.40534891979;40027.7998610008;40052.59947400547;40057.79971100126;40068.79965600153;3325.534425180477;3375.3249350130072;3763.6612704856693;3973.4635824163656;4001.3197756381487;29593.26016849596;29742.70257297421;29989.400211995857;31607;31696.841515792505;3321.983390083058;3352.094934367707;3372.392969265531;3381.374445727524;3405.8590372225335;204969;258745;259027.70486147638;259120;259587.63711265888;52043.219351709755;58620.41379586235;58799.41200588025;59446.70276648676;59452;56752;62334.68832655808;62533.374666253665;62576.68711656413;62643.6867815658;15740.449084282223;16097.919510402373;16105.114218717848;16109.516714498584;16121.838781612269;11046.281991670516;11297.20919535641;11515.25150865191;11749.941250293694;11914.940425297818;19626.411207663794;19829.30597429083;19904.402867913985;19915.302964396178;19945.401637950596;7238.348548630648;7314.414846812242;7364.521306115085;7453.291937265951;7470.3276705096805;895.3508706187962;984.07988530724;1042.6819819954987;1044.498640652491;1109.7835921995295;28760.137195884156;28765.712342876304;28936.710632893824;29280.121596352143;29288.414231715247;998.9100980911608;1007.7480629842539;1057.6509751781894;1063.1335461598771;1085.8696956365286;14988;15468.226588670746;15673.529794106194;15687.68624627501;15791.21043947798;357423;360329;361164;361367;362896;51158;51453.74273128685;51548.742256288475;51582.74208628933;51683;1190.1847234644124;1280.1742875845027;1295.2681734819796;1313.848907375645;1328.110166188656;28814.135575932756;29593.85203073971;29754.256143596584;30154;30495.08514744561;38665.42001869918;38747.806260968515;39073.41389879211;39077.41383879187;39120.21759564849;274574;274677;275798;275878;276056.9577216889;23425.531489370456;24059.879700601385;25489.49021019606;26161.215163545123;26215.34461638398;42916;43189.78405107954;43355.566444336415;43516;44497.55502445064;36760.63239367679;36921.44617830681;37156.25687486289;37359;37778.811105944296;34240.48639270363;36582.8170859144;36812.815935920145;36947.630523695494;37255.81372093122;32454;37886.62113378831;38111.23777524378;39027;42458.787706061274;32247.618857251142;34505.82747086249;34509.48235776415;34531;34632.480512792834;25515.617265740657;25922.75965504312;26114.86942565351;26131.346716332242;26466.073687421616 01:45:04 INFO - PROCESS | 17908 | |2;jquery.html;381.3916802699693;382.93298672732266;387.0710295291301;394.5167170216487;406.080228282939;13795.724085518284;14412;15437.382504699812;18356.632867342647;18386.816131838696;16563.25465354059;17328.480145595622;17451.21469533871;18549.165287562057;18582.535436614093;4522.937109779199;5104.132297509414;5274.894502109955;5289.153735402337;5290.338707661543;5219.765110570033;5238.580913526908;5257.474252574751;5279.366476022883;5279.841604751864;5026.748662566857;5224.869378265555;5232.633715639888;5238.711870847102;5242.737863106849;5178.844634660966;5208.635395522315;5214.322138122057;5233.973830130844;5243.947560524384;4539.251023581105;4612.238980568202;4665.393498845162;4676.321933319684;4679.15775160471;20603.175872965065;21256.681149782766;21578.24476143343;21579.46051348713;21617.135314587398;1977.9109940052733;2038.6738121900573;2235.284708893155;2256.763039880822;2428.162284012013;13239.602811915658;13392.665183370396;13427.66430839227;13695.657608559866;13760.380782864795;1767.4874286456911;1767.5757818123686;1797.379903933141;1830.533214030427;1840.9263629454806;69147;69933;70022.29977700209;70247;71060;9447.90552094484;9772.706818795448;9869.555869985868;9874.456904870302;10027.649032283834;11905.226160299553;12170.57402990891;13633.590992270249;13692.589222323346;13721.176729396268;7002.614856182959;7339.412846972229;7421.703131874665;7446.069241344832;7581.241875812485;7185.389241914391;7194.604296763729;7357.5953322567775;7359.926400736032;7381.594012329266;6032.276126864716;6159.137720719103;6253.906191407133;6267.2165979252595;6291.622502649764;1746.3538490758247;1766.1787268920014;1796.9191386387645;1818.6362727454562;1865.4590168851153;931.6739141300491;936;959.1511512311655;978.1538968791943;1076.3649446826253;16279.837201628068;16942.40701575439;16953;17650.646987060187;17892.28430862751;941.3598752848129;965.1795973422535;971.965981190669;974.6880998080546;979.7354714227118;9991.700248992542;10293.897061029444;10301.742456438498;10319.380837149645;10322.174226061898;370458;370878;376995;377057;379217;69037.3096269041;83482.58258708668;85768;86552.56723716341;87093;439.9802008909607;456.50013235507066;456.5388957153233;457.1725177428798;458.0701176611484;9735.513224338896;10117.19062475015;10377.688669339932;10496.107830834158;10503.159747220052;24770.876145619157;31181.68818311788;32687.019389418354;33910.321793564486;37287.81356093202;46058.30912536247;46307.305390419846;46549.3017604743;46637.53362466468;46980.53019469762;7569.545827250383;7589;7597.886031709419;7720.652570634447;7733.419993500623;9716.611335546782;11443.771124577628;11571.942140289244;11793.233439826385;11963.521459141537;10139.89860101419;10167.339122956984;10466.895331046897;10543.789124217627;10692.358458492516;9881.85177222328;10188.949055254676;10530.262881598215;10632;10704.946475267574;10398.064174224357;10475.109615682752;10492.947535262274;10684.626038088629;10743.785124297627;7657.617119143909;7831.177726338652;7882.330001949898;7979.640916158671;8101;8054.758357249292;9400.529973501434;10227.846582301123;10508.159347252355;10584.153267738408 01:45:04 INFO - PROCESS | 17908 | |3;mootools.html;1291.689994401344;1528.4039224702365;1553.0215963942715;1734.2802736864203;1854.5675834754938;7000.754973575926;7247.42020638349;7303.634818259079;7508.9624551877305;7518.924810751904;7428.257174282569;7467.626618669058;7550.509216900911;7559.281868222523;7571.356434703057;2200.966985495219;2228.9888550557225;2229.6209644360497;2230.609643312414;2230.6654001899765;2248.067052173354;2265;2305.4121199094207;2307.9538409231805;2312.5952958232324;2189.7956124131665;2203.2398822406244;2220.9000594973263;2229.2532001779423;2234.82121430286;2150.5698860227862;2166.6100101981638;2183.1376606240524;2184.552166805817;2187.846850720442;2168.479564904427;2176.5320456101854;2176.62997290461;2176.847620666554;2176.880271585062;7410.03669522964;7464.813379665497;7466.365358944442;7470.103587569526;7648.311651951351;4599.655025873073;4765.666403351766;4788.760561971888;4795.6882802618065;4799.016201678647;2959.8520073996215;2984.880604775806;2989.3274013346822;2997.5054116070824;3047.3143542702937;927.9907200927972;928.4522131942119;931.180561106229;946.6592026870321;953.427943234061;10689.144868410509;10775.137988960865;10783.5686572537;10785.514651840685;10830.458477076114;4069.4709687740406;4173.52004519478;4190.559991200941;4213.9578604214175;4246.702730808814;8453.239208471266;8595.699150529701;8600.0109987351;8618.741437756877;8624.482531048157;4629.791659375336;4635.58279754817;4640.373549570765;4641.373414589055;4642.37327960721;3759.9436008459893;4168.583141685807;4215.473065866767;4281.293586558245;4314.50383205929;3374.4938259261307;3375.6159974410375;3447.1899103710607;3466.341395134916;3468.150303175738;969.1132613658565;1036.3678156324636;1036.657902892044;1040.8022475729588;1041.7031146123318;643.5173619785161;751.9887201691979;841.6927821345165;844.5523872347666;904.6200595749801;5186.818461353834;5239.921401178985;5299.708516031578;5392.379876314196;5480.862978425492;913.8439873559952;957.3490026781856;957.5690939077443;963.2967933408651;965.6861520005885;3700.925981480409;3709.7774133552075;3759.567649720317;3785.772853628736;3795.411711184771;9314.161725444743;9435.764105897408;9627.326087173831;9799.706008819747;9802.852957205647;9573.32986690925;9607.51962401877;9617.663381781744;9731.513424328756;9748.61005559784;7034.718611255493;7176;7181.676824542908;7418.925810741824;7463.253674632602;5232.215167724872;5311.681299122065;5340.145576707863;5347.465253474621;5357.758900849393;8340.541270230196;8511.404201705822;8517.829643407222;8529.104444033288;8546.059933407196;8551.1448855114;8570.057293697813;8608.311335093053;8670.219680228809;8719.738407847775;5854.443827836349;6307.3377295383325;6490.610563366213;6843.349881761224;6989.685464154227;7129.25142860013;7156.463265255231;7185.419207774281;7203.8919416207755;7222.927770722225;6314.084457753692;6453.967730161319;6481.027845822976;6565.573237739723;6577.309382514767;6396.296407395276;6405.167328247298;6410.711517981609;6468.320826313169;6504;6241.21984751906;6254.718537665725;6287.276963149114;6287.842803929939;6292.653904035139;4552.908941821212;4567.2007398705755;4609.700369475973;4654.069186162713;4662.370579971661;4321.654267658642;4348.695591308578;4358.6295164911335;4418.867433976986;4444.266695995125 01:45:04 INFO - PROCESS | 17908 | |4;prototype.html;308.2540252588735;310.8135118928643;313.0654994840401;316.45569620253156;317.57603599195073;4631.884202894929;4635.374224479694;4684.648651351154;4689.718616882989;4730.19586670266;4608.861734147972;4625.930611040837;4630.328602352657;4650.953490465095;4692.741899195551;3522.172289511963;3618.8190590470504;3641.1443310821937;3716.2905063670746;3735.8505659773577;3673.687736542397;3703.962960370389;3713.4589145504583;3713.591504934455;3724.9068773280615;3490.5287786148797;3636.8545258189774;3652.6485200475727;3682.466042423847;3688.3360995020885;3576.4635304704243;3662.450632405134;3724.42271447926;3731.104534911629;3734.7012239020814;3315.4529502632035;3317.5355450236984;3320.634730179678;3332.800031998064;3334.3831391192707;4432.180046691373;4445.9110817783785;4482.260427029536;4484.8206071757095;4499.6400287976885;3930.6658933990643;4156.251874662559;4161.063760653859;4225.429567008446;4274.166537525184;4850.490698476645;4864.756762161913;4869.245266983623;4872.537108974641;4875.268709693539;3503.7722548034294;3506.982465087658;3510.6313837046996;3521.753477256593;3545.8936231913085;4855.36880205571;4966.528179822947;5123.564497017758;5147.794088236466;5150.150225212836;3550.1657110578994;3569.8929032129076;3583.283343331344;3584.121890136881;3587.515685382492;3629.764065335745;3639;3641.9271614568092;3648.5074514940675;3651.214988777426;4156.56356082613;4160.583941605815;4172.248995180897;4174.269502836992;4178.185253875465;4678.321643361762;4868.878278043077;4870.611875615433;4880.682755620874;4901.411830580282;1217.6301660631789;1229.059769276504;1234.8950339221087;1236.2891337480985;1239.4484454417877;799.5842162075688;832.76682528892;840.2269911681268;845.7124577643508;847.6948298612494;4131.814068366871;4138.255114079495;4138.482689663792;4178.498580170338;4190.874273771792;4769.523047695272;4796.712197268175;4829.758512074382;4836.395450568679;4858.902821943541;4021.4369988201674;4138.441310423114;4169.207850508394;4175.728577642443;4176.2691528982305;2541.1995221505167;2542.453372524879;2549.2155491156263;2556.2714626331776;2557.1689201009744;4537.8184872604725;4554.88612784683;4573.931391029138;4584.839530616479;4587.564181402761;4640.79116439761;4882.218844984856;4884.145274576935;4899.191633380452;4909.134528879074;4566.908661826745;4571.382863313476;4621.907561848744;4622.560856718606;4643.3731446255;4876.4392094909535;4891.951080489292;4896.4124305083615;4904.852854414374;4923.187674033744;4505.481869584909;4643.860684179345;4668.673192876466;4739.976300118477;4752.287156926489;4463.464384273908;4512.210363186364;4530.818767249273;4562.543745625411;4634.9536504634525;3426.9657303426648;3481.7388695848417;3485.407480728333;3491.4064609017037;3499.757586056913;4784.856454306377;4837.250226214942;4848.5636292733825;4868.148074087091;4875.268709693574;4446.355278484666;4692.639134650913;4725.385699858996;4733.21342925665;4737.928931066106;4697.459792123813;4707.2939059140035;4711.858644240679;4714.292856071616;4719.504452032487;4592.793324300348;4624.075184962953;4635.976820115878;4645.3032045193495;4648.814047438064;4501.437320334958;4714.575688187942;4731.834385796618;4743.762811859324;4869.391326084239;4755.714657120584;4766.928496072631;4782.832600858953;4795.280707893844;4796.424429068395 01:45:04 INFO - PROCESS | 17908 | |5;yui.html;739.7632757517597;764.6024067484908;795.8937077462328;823.7623762376238;839.3788596438637;11435.42822858857;11487.942560287207;11513.136514761385;11565.942170289136;11629.302241865484;12620.24278543288;12685.112042157052;12704.555340563082;13231.536896208634;13812.171269723824;682.5802131689026;883.5935469683938;890.568074483878;891.5453118909338;891.9821603567925;851.3231980575426;872.0233338660709;877.2411863737884;885.2077390735288;885.6900084970241;929.9674511392069;932.3520153493325;933.3000249812641;933.7572231219864;934.3319526538523;712.3410844968383;886.4459712679575;919.8252332056921;921.2261700171854;922.0364718868731;676.455453360045;678.7285085965603;679.5956405938458;679.7926632377123;680.0649107477219;13183.143095698844;13225.86774132256;13264.3367831609;13286.20282783036;13288.335583220896;11682;12133;12292;12306.323152226623;12388.132830701854;9776.51117444125;9916.752081197956;9948.90051099487;10009.19926405893;10422.21833362501;3325.1354647791504;3341.899743007714;3384.729221662261;3403.880864169767;3481.54739883816;43155.56844431547;43599.56400436018;43615.563844361466;44708.329375059075;44927;9528.659876173413;9574.090461406295;9610.51947402627;9616.912812054989;9773.804523909625;16532.917335413247;16551.25519351632;16605.252763625667;16646.91676541634;16648.75026874598;6728.899066514006;6755.459563235027;6766.763163289262;6889.173299204027;6926.58440493572;3775.5091838061426;3784.2242340320167;3798.924021519554;3840.0591854995705;3855.5373355196994;2879.1074766822353;2978.4638765022505;2980.1208643450236;2980.716831900966;2981.4037192561573;503.04923694217956;515.6905856486078;516.1715446708055;520.4639221601756;527.6412039812964;620.9316975132732;634.7016902056026;635.3138610300956;650.0801366067057;654.7446495866616;7848.13670496245;7875.369970402354;7907.644156012878;7987.56068416231;8103.88837947008;515.5385929592993;584.7310237290894;612.4426771637877;617.2623714661026;639.8528338482175;3573.5610222115906;3647.963520364762;3740.7194460415576;3835.1562656215588;3896.1428485733095;46012.30981535213;47288;47397.289040664415;47752.76123619429;49795.50204497909;44193.77903110464;44683.776581117534;45564;45574.544254557695;46124.30813537799;40575.59424405777;40628.59371406307;41370.37944430836;41830;41881.79059104685;7959.323457506177;8009.3192078673965;8014.118446970945;8050.235227653364;8092.514449133071;29655.406891862473;29923.70076299209;30009.249768755955;30112.84943575268;30918;34512.65487345094;35880.4617930726;37475.43786843254;37600;38024.619753803214;10864.891351086704;10867.13062954946;10931.234813563293;11165.330080195214;11219.382933938712;11120.777584448104;11236.213465057694;11890;12320.260784352968;12591.559295424617;11270.549178032787;11481.712957176138;11521.654350369503;11911.106666999836;11911.880881191077;10793.190510711886;11384.829227561428;11737;11779.411029448322;11840.171188016757;11083.279586827153;11591.130665199975;11986.460609272777;12080.275183488668;12091.818622720843;8888.822223555622;9287.164155226063;9402.15380615748;9444.291678124306;9648.653914364166;8716.3462740296;9160.587773550073;9508.239340852853;9903.405795652285;10147.289689721649 01:45:04 INFO - PROCESS | 17908 | __end_tp_report 01:45:04 INFO - PROCESS | 17908 | __start_cc_report 01:45:04 INFO - PROCESS | 17908 | _x_x_mozilla_cycle_collect,925 01:45:04 INFO - PROCESS | 17908 | __end_cc_report 01:45:04 INFO - PROCESS | 17908 | __startTimestamp1462697104245__endTimestamp 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - PROCESS | 17908 | ------- Summary: start ------- 01:45:04 INFO - PROCESS | 17908 | Number of tests: 6 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - PROCESS | 17908 | [#0] dojo.html Cycles:165 Average:4515.26 Median:4613.35 stddev:446.76 (9.7%) stddev-sans-first:421.47 01:45:04 INFO - PROCESS | 17908 | Values: 2577.2 2595.5 2620.5 2620.7 2627.7 4514.5 4548.6 4550.7 4585.4 4590.0 4519.9 4531.6 4564.5 4613.4 4625.7 4155.9 4201.4 4233.2 4259.9 4384.2 4330.7 4352.5 4357.0 4364.7 4403.4 4151.6 4203.0 4205.0 4231.2 4267.3 4257.0 4265.7 4268.5 4311.3 4356.7 4286.8 4291.3 4296.4 4308.0 4345.2 4325.1 4387.7 4424.9 4565.4 4606.2 4784.1 4868.9 4869.6 4870.3 4871.6 4843.8 4847.9 4858.4 4894.1 4896.2 4472.2 4564.8 4572.6 4611.1 4618.9 5041.8 5062.5 5071.7 5090.6 5103.1 4757.2 4758.7 4790.0 4795.5 4804.0 4764.8 4777.1 4813.7 4835.5 4875.8 4769.9 4788.6 4797.2 4830.2 4848.6 4794.1 4794.9 4797.8 4806.9 4845.8 4102.6 4137.4 4142.5 4150.1 4190.8 3705.0 3705.0 3710.2 3711.5 3712.3 4166.0 4178.3 4213.0 4218.7 4221.2 4828.2 4861.1 4867.2 4871.4 4921.2 4197.2 4197.2 4200.5 4235.5 4240.1 4329.5 4350.1 4365.9 4406.3 4407.8 4575.5 4577.6 4584.6 4590.3 4622.8 4783.2 4829.7 4832.4 4838.1 4868.6 4547.6 4571.6 4579.9 4591.5 4614.3 4822.2 4823.8 4825.7 4825.8 4850.4 4877.5 4884.6 4886.8 4888.1 4939.7 4590.6 4686.1 4714.7 4735.9 4751.8 4719.9 4727.5 4749.0 4753.8 4803.3 4583.2 4687.4 4701.1 4747.6 4750.6 4726.1 4802.0 4802.5 4804.0 4809.8 4621.1 4643.1 4644.2 4648.9 4694.7 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - PROCESS | 17908 | [#1] ext.html Cycles:180 Average:46447.59 Median:37051.94 stddev:78337.25 (211.4%) stddev-sans-first:78481.38 01:45:04 INFO - PROCESS | 17908 | Values: 602.6 609.7 617.5 629.9 634.9 42080.0 43266.4 43313.4 47514.3 47581.0 42672.4 43115.4 43131.0 43147.4 43150.8 7887.2 7962.0 7983.3 8015.2 8023.6 7848.7 7928.2 7931.5 7931.7 7933.2 7924.0 7952.5 7953.8 7980.3 7990.7 7933.4 7969.2 7972.1 7976.1 7976.7 7876.9 7948.0 7949.6 7954.6 7954.9 39643.4 40027.8 40052.6 40057.8 40068.8 3325.5 3375.3 3763.7 3973.5 4001.3 29593.3 29742.7 29989.4 31607.0 31696.8 3322.0 3352.1 3372.4 3381.4 3405.9 204969.0 258745.0 259027.7 259120.0 259587.6 52043.2 58620.4 58799.4 59446.7 59452.0 56752.0 62334.7 62533.4 62576.7 62643.7 15740.4 16097.9 16105.1 16109.5 16121.8 11046.3 11297.2 11515.3 11749.9 11914.9 19626.4 19829.3 19904.4 19915.3 19945.4 7238.3 7314.4 7364.5 7453.3 7470.3 895.4 984.1 1042.7 1044.5 1109.8 28760.1 28765.7 28936.7 29280.1 29288.4 998.9 1007.7 1057.7 1063.1 1085.9 14988.0 15468.2 15673.5 15687.7 15791.2 357423.0 360329.0 361164.0 361367.0 362896.0 51158.0 51453.7 51548.7 51582.7 51683.0 1190.2 1280.2 1295.3 1313.8 1328.1 28814.1 29593.9 29754.3 30154.0 30495.1 38665.4 38747.8 39073.4 39077.4 39120.2 274574.0 274677.0 275798.0 275878.0 276057.0 23425.5 24059.9 25489.5 26161.2 26215.3 42916.0 43189.8 43355.6 43516.0 44497.6 36760.6 36921.4 37156.3 37359.0 37778.8 34240.5 36582.8 36812.8 36947.6 37255.8 32454.0 37886.6 38111.2 39027.0 42458.8 32247.6 34505.8 34509.5 34531.0 34632.5 25515.6 25922.8 26114.9 26131.3 26466.1 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - PROCESS | 17908 | [#2] jquery.html Cycles:180 Average:23824.51 Median:423.03 stddev:62095.06 (14678.6%) stddev-sans-first:62244.30 01:45:04 INFO - PROCESS | 17908 | Values: 381.4 382.9 387.1 394.5 406.1 13795.7 14412.0 15437.4 18356.6 18386.8 16563.3 17328.5 17451.2 18549.2 18582.5 4522.9 5104.1 5274.9 5289.2 5290.3 5219.8 5238.6 5257.5 5279.4 5279.8 5026.7 5224.9 5232.6 5238.7 5242.7 5178.8 5208.6 5214.3 5234.0 5243.9 4539.3 4612.2 4665.4 4676.3 4679.2 20603.2 21256.7 21578.2 21579.5 21617.1 1977.9 2038.7 2235.3 2256.8 2428.2 13239.6 13392.7 13427.7 13695.7 13760.4 1767.5 1767.6 1797.4 1830.5 1840.9 69147.0 69933.0 70022.3 70247.0 71060.0 9447.9 9772.7 9869.6 9874.5 10027.6 11905.2 12170.6 13633.6 13692.6 13721.2 7002.6 7339.4 7421.7 7446.1 7581.2 7185.4 7194.6 7357.6 7359.9 7381.6 6032.3 6159.1 6253.9 6267.2 6291.6 1746.4 1766.2 1796.9 1818.6 1865.5 931.7 936.0 959.2 978.2 1076.4 16279.8 16942.4 16953.0 17650.6 17892.3 941.4 965.2 972.0 974.7 979.7 9991.7 10293.9 10301.7 10319.4 10322.2 370458.0 370878.0 376995.0 377057.0 379217.0 69037.3 83482.6 85768.0 86552.6 87093.0 440.0 456.5 456.5 457.2 458.1 9735.5 10117.2 10377.7 10496.1 10503.2 24770.9 31181.7 32687.0 33910.3 37287.8 46058.3 46307.3 46549.3 46637.5 46980.5 7569.5 7589.0 7597.9 7720.7 7733.4 9716.6 11443.8 11571.9 11793.2 11963.5 10139.9 10167.3 10466.9 10543.8 10692.4 9881.9 10188.9 10530.3 10632.0 10704.9 10398.1 10475.1 10492.9 10684.6 10743.8 7657.6 7831.2 7882.3 7979.6 8101.0 8054.8 9400.5 10227.8 10508.2 10584.2 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - PROCESS | 17908 | [#3] mootools.html Cycles:180 Average:5057.00 Median:5352.61 stddev:2784.27 (52.0%) stddev-sans-first:2777.70 01:45:04 INFO - PROCESS | 17908 | Values: 1291.7 1528.4 1553.0 1734.3 1854.6 7000.8 7247.4 7303.6 7509.0 7518.9 7428.3 7467.6 7550.5 7559.3 7571.4 2201.0 2229.0 2229.6 2230.6 2230.7 2248.1 2265.0 2305.4 2308.0 2312.6 2189.8 2203.2 2220.9 2229.3 2234.8 2150.6 2166.6 2183.1 2184.6 2187.8 2168.5 2176.5 2176.6 2176.8 2176.9 7410.0 7464.8 7466.4 7470.1 7648.3 4599.7 4765.7 4788.8 4795.7 4799.0 2959.9 2984.9 2989.3 2997.5 3047.3 928.0 928.5 931.2 946.7 953.4 10689.1 10775.1 10783.6 10785.5 10830.5 4069.5 4173.5 4190.6 4214.0 4246.7 8453.2 8595.7 8600.0 8618.7 8624.5 4629.8 4635.6 4640.4 4641.4 4642.4 3759.9 4168.6 4215.5 4281.3 4314.5 3374.5 3375.6 3447.2 3466.3 3468.2 969.1 1036.4 1036.7 1040.8 1041.7 643.5 752.0 841.7 844.6 904.6 5186.8 5239.9 5299.7 5392.4 5480.9 913.8 957.3 957.6 963.3 965.7 3700.9 3709.8 3759.6 3785.8 3795.4 9314.2 9435.8 9627.3 9799.7 9802.9 9573.3 9607.5 9617.7 9731.5 9748.6 7034.7 7176.0 7181.7 7418.9 7463.3 5232.2 5311.7 5340.1 5347.5 5357.8 8340.5 8511.4 8517.8 8529.1 8546.1 8551.1 8570.1 8608.3 8670.2 8719.7 5854.4 6307.3 6490.6 6843.3 6989.7 7129.3 7156.5 7185.4 7203.9 7222.9 6314.1 6454.0 6481.0 6565.6 6577.3 6396.3 6405.2 6410.7 6468.3 6504.0 6241.2 6254.7 6287.3 6287.8 6292.7 4552.9 4567.2 4609.7 4654.1 4662.4 4321.7 4348.7 4358.6 4418.9 4444.3 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - PROCESS | 17908 | [#4] prototype.html Cycles:180 Average:3987.74 Median:4534.32 stddev:1130.18 (24.9%) stddev-sans-first:1099.09 01:45:04 INFO - PROCESS | 17908 | Values: 308.3 310.8 313.1 316.5 317.6 4631.9 4635.4 4684.6 4689.7 4730.2 4608.9 4625.9 4630.3 4651.0 4692.7 3522.2 3618.8 3641.1 3716.3 3735.9 3673.7 3704.0 3713.5 3713.6 3724.9 3490.5 3636.9 3652.6 3682.5 3688.3 3576.5 3662.5 3724.4 3731.1 3734.7 3315.5 3317.5 3320.6 3332.8 3334.4 4432.2 4445.9 4482.3 4484.8 4499.6 3930.7 4156.3 4161.1 4225.4 4274.2 4850.5 4864.8 4869.2 4872.5 4875.3 3503.8 3507.0 3510.6 3521.8 3545.9 4855.4 4966.5 5123.6 5147.8 5150.2 3550.2 3569.9 3583.3 3584.1 3587.5 3629.8 3639.0 3641.9 3648.5 3651.2 4156.6 4160.6 4172.2 4174.3 4178.2 4678.3 4868.9 4870.6 4880.7 4901.4 1217.6 1229.1 1234.9 1236.3 1239.4 799.6 832.8 840.2 845.7 847.7 4131.8 4138.3 4138.5 4178.5 4190.9 4769.5 4796.7 4829.8 4836.4 4858.9 4021.4 4138.4 4169.2 4175.7 4176.3 2541.2 2542.5 2549.2 2556.3 2557.2 4537.8 4554.9 4573.9 4584.8 4587.6 4640.8 4882.2 4884.1 4899.2 4909.1 4566.9 4571.4 4621.9 4622.6 4643.4 4876.4 4892.0 4896.4 4904.9 4923.2 4505.5 4643.9 4668.7 4740.0 4752.3 4463.5 4512.2 4530.8 4562.5 4635.0 3427.0 3481.7 3485.4 3491.4 3499.8 4784.9 4837.3 4848.6 4868.1 4875.3 4446.4 4692.6 4725.4 4733.2 4737.9 4697.5 4707.3 4711.9 4714.3 4719.5 4592.8 4624.1 4636.0 4645.3 4648.8 4501.4 4714.6 4731.8 4743.8 4869.4 4755.7 4766.9 4782.8 4795.3 4796.4 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - PROCESS | 17908 | [#5] yui.html Cycles:180 Average:12531.17 Median:43904.67 stddev:13708.41 (31.2%) stddev-sans-first:13718.26 01:45:04 INFO - PROCESS | 17908 | Values: 739.8 764.6 795.9 823.8 839.4 11435.4 11487.9 11513.1 11565.9 11629.3 12620.2 12685.1 12704.6 13231.5 13812.2 682.6 883.6 890.6 891.5 892.0 851.3 872.0 877.2 885.2 885.7 930.0 932.4 933.3 933.8 934.3 712.3 886.4 919.8 921.2 922.0 676.5 678.7 679.6 679.8 680.1 13183.1 13225.9 13264.3 13286.2 13288.3 11682.0 12133.0 12292.0 12306.3 12388.1 9776.5 9916.8 9948.9 10009.2 10422.2 3325.1 3341.9 3384.7 3403.9 3481.5 43155.6 43599.6 43615.6 44708.3 44927.0 9528.7 9574.1 9610.5 9616.9 9773.8 16532.9 16551.3 16605.3 16646.9 16648.8 6728.9 6755.5 6766.8 6889.2 6926.6 3775.5 3784.2 3798.9 3840.1 3855.5 2879.1 2978.5 2980.1 2980.7 2981.4 503.0 515.7 516.2 520.5 527.6 620.9 634.7 635.3 650.1 654.7 7848.1 7875.4 7907.6 7987.6 8103.9 515.5 584.7 612.4 617.3 639.9 3573.6 3648.0 3740.7 3835.2 3896.1 46012.3 47288.0 47397.3 47752.8 49795.5 44193.8 44683.8 45564.0 45574.5 46124.3 40575.6 40628.6 41370.4 41830.0 41881.8 7959.3 8009.3 8014.1 8050.2 8092.5 29655.4 29923.7 30009.2 30112.8 30918.0 34512.7 35880.5 37475.4 37600.0 38024.6 10864.9 10867.1 10931.2 11165.3 11219.4 11120.8 11236.2 11890.0 12320.3 12591.6 11270.5 11481.7 11521.7 11911.1 11911.9 10793.2 11384.8 11737.0 11779.4 11840.2 11083.3 11591.1 11986.5 12080.3 12091.8 8888.8 9287.2 9402.2 9444.3 9648.7 8716.3 9160.6 9508.2 9903.4 10147.3 01:45:04 INFO - PROCESS | 17908 | -------- Summary: end -------- 01:45:04 INFO - PROCESS | 17908 | 01:45:04 INFO - TEST-INFO | 17908: exit 0 01:45:05 INFO - TEST-OK | dromaeo_css | took 1117559ms 01:45:05 INFO - TEST-START | kraken 01:45:05 INFO - operating with platform_type : linux_ 01:45:05 INFO - Initialising browser for kraken test... 01:45:05 INFO - TEST-INFO | started process 18086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0blDcz/profile http://localhost:52803/getInfo.html) 01:45:09 INFO - PROCESS | 18086 | __metrics Screen width/height:1600/1200 01:45:09 INFO - PROCESS | 18086 | colorDepth:24 01:45:09 INFO - PROCESS | 18086 | Browser inner width/height: 1024/697 01:45:09 INFO - PROCESS | 18086 | __metrics 01:45:10 ERROR - PROCESS | 18086 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:45:10 INFO - TEST-INFO | 18086: exit 0 01:45:10 INFO - Browser initialized. 01:45:10 INFO - Running cycle 1/1 for kraken test... 01:45:10 INFO - TEST-INFO | started process 18167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0blDcz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:22 INFO - PROCESS | 18167 | RSS: Main: 154161152 01:45:22 INFO - PROCESS | 18167 | 01:45:25 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-beat-detection) 01:45:26 INFO - PROCESS | 18167 | RSS: Main: 210329600 01:45:26 INFO - PROCESS | 18167 | 01:45:29 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-dft) 01:45:29 INFO - PROCESS | 18167 | RSS: Main: 198520832 01:45:29 INFO - PROCESS | 18167 | 01:45:33 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-fft) 01:45:33 INFO - PROCESS | 18167 | RSS: Main: 266223616 01:45:33 INFO - PROCESS | 18167 | 01:45:35 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52803/tests/kraken/driver.html?testName=audio-oscillator) 01:45:36 INFO - PROCESS | 18167 | RSS: Main: 175984640 01:45:36 INFO - PROCESS | 18167 | 01:45:38 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:39 INFO - PROCESS | 18167 | RSS: Main: 180490240 01:45:39 INFO - PROCESS | 18167 | 01:45:42 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:43 INFO - PROCESS | 18167 | RSS: Main: 215572480 01:45:43 INFO - PROCESS | 18167 | 01:45:46 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52803/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:47 INFO - PROCESS | 18167 | RSS: Main: 216702976 01:45:47 INFO - PROCESS | 18167 | 01:45:49 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52803/tests/kraken/driver.html?testName=json-parse-financial) 01:45:50 INFO - PROCESS | 18167 | RSS: Main: 216760320 01:45:50 INFO - PROCESS | 18167 | 01:45:52 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:52 INFO - PROCESS | 18167 | RSS: Main: 204038144 01:45:52 INFO - PROCESS | 18167 | 01:45:54 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:55 INFO - PROCESS | 18167 | RSS: Main: 210190336 01:45:55 INFO - PROCESS | 18167 | 01:45:57 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:58 INFO - PROCESS | 18167 | RSS: Main: 218554368 01:45:58 INFO - PROCESS | 18167 | 01:46:01 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:01 INFO - PROCESS | 18167 | RSS: Main: 223014912 01:46:01 INFO - PROCESS | 18167 | 01:46:04 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:05 INFO - PROCESS | 18167 | RSS: Main: 220516352 01:46:05 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | Cycle 1(1): loaded http://localhost:52803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52803/tests/kraken/driver.html?testName=ai-astar) 01:46:07 INFO - PROCESS | 18167 | RSS: Main: 265732096 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | __start_tp_report 01:46:07 INFO - PROCESS | 18167 | _x_x_mozilla_page_load 01:46:07 INFO - PROCESS | 18167 | _x_x_mozilla_page_load_details 01:46:07 INFO - PROCESS | 18167 | |i|pagename|runs| 01:46:07 INFO - PROCESS | 18167 | |0;ai-astar;114;108;114;113;112;115;115;113;112;112 01:46:07 INFO - PROCESS | 18167 | |1;audio-beat-detection;169;130;163;189;131;152;153;141;199;140 01:46:07 INFO - PROCESS | 18167 | |2;audio-dft;161;162;161;160;161;162;163;162;161;160 01:46:07 INFO - PROCESS | 18167 | |3;audio-fft;75;75;76;124;76;75;77;76;131;76 01:46:07 INFO - PROCESS | 18167 | |4;audio-oscillator;94;94;125;92;94;94;121;93;93;127 01:46:07 INFO - PROCESS | 18167 | |5;imaging-gaussian-blur;116;116;117;117;118;117;116;117;117;117 01:46:07 INFO - PROCESS | 18167 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;146;146 01:46:07 INFO - PROCESS | 18167 | |7;imaging-desaturate;95;95;95;94;95;95;94;95;95;94 01:46:07 INFO - PROCESS | 18167 | |8;json-parse-financial;66;65;67;65;66;67;69;94;67;64 01:46:07 INFO - PROCESS | 18167 | |9;json-stringify-tinderbox;65;65;65;66;65;64;65;67;65;65 01:46:07 INFO - PROCESS | 18167 | |10;stanford-crypto-aes;82;81;82;81;82;85;89;84;88;83 01:46:07 INFO - PROCESS | 18167 | |11;stanford-crypto-ccm;142;133;135;138;129;139;132;130;222;134 01:46:07 INFO - PROCESS | 18167 | |12;stanford-crypto-pbkdf2;175;176;177;174;172;173;185;174;176;172 01:46:07 INFO - PROCESS | 18167 | |13;stanford-crypto-sha256-iterative;75;69;68;68;70;81;67;70;70;69 01:46:07 INFO - PROCESS | 18167 | __end_tp_report 01:46:07 INFO - PROCESS | 18167 | __start_cc_report 01:46:07 INFO - PROCESS | 18167 | _x_x_mozilla_cycle_collect,1845 01:46:07 INFO - PROCESS | 18167 | __end_cc_report 01:46:07 INFO - PROCESS | 18167 | __startTimestamp1462697167353__endTimestamp 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | ------- Summary: start ------- 01:46:07 INFO - PROCESS | 18167 | Number of tests: 14 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.50 stddev:2.04 (1.8%) stddev-sans-first:2.12 01:46:07 INFO - PROCESS | 18167 | Values: 114.0 108.0 114.0 113.0 112.0 115.0 115.0 113.0 112.0 112.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:158.00 stddev:23.47 (14.9%) stddev-sans-first:24.47 01:46:07 INFO - PROCESS | 18167 | Values: 169.0 130.0 163.0 189.0 131.0 152.0 153.0 141.0 199.0 140.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 01:46:07 INFO - PROCESS | 18167 | Values: 161.0 162.0 161.0 160.0 161.0 162.0 163.0 162.0 161.0 160.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#3] audio-fft Cycles:10 Average:86.10 Median:76.00 stddev:21.89 (28.8%) stddev-sans-first:22.85 01:46:07 INFO - PROCESS | 18167 | Values: 75.0 75.0 76.0 124.0 76.0 75.0 77.0 76.0 131.0 76.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:93.50 stddev:15.01 (16.1%) stddev-sans-first:15.59 01:46:07 INFO - PROCESS | 18167 | Values: 94.0 94.0 125.0 92.0 94.0 94.0 121.0 93.0 93.0 127.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 01:46:07 INFO - PROCESS | 18167 | Values: 116.0 116.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 01:46:07 INFO - PROCESS | 18167 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:46:07 INFO - PROCESS | 18167 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:67.00 stddev:8.89 (13.3%) stddev-sans-first:9.37 01:46:07 INFO - PROCESS | 18167 | Values: 66.0 65.0 67.0 65.0 66.0 67.0 69.0 94.0 67.0 64.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 01:46:07 INFO - PROCESS | 18167 | Values: 65.0 65.0 65.0 66.0 65.0 64.0 65.0 67.0 65.0 65.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.50 stddev:2.83 (3.4%) stddev-sans-first:2.93 01:46:07 INFO - PROCESS | 18167 | Values: 82.0 81.0 82.0 81.0 82.0 85.0 89.0 84.0 88.0 83.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:136.50 stddev:27.91 (20.4%) stddev-sans-first:29.60 01:46:07 INFO - PROCESS | 18167 | Values: 142.0 133.0 135.0 138.0 129.0 139.0 132.0 130.0 222.0 134.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:175.50 stddev:3.78 (2.2%) stddev-sans-first:4.00 01:46:07 INFO - PROCESS | 18167 | Values: 175.0 176.0 177.0 174.0 172.0 173.0 185.0 174.0 176.0 172.0 01:46:07 INFO - PROCESS | 18167 | 01:46:07 INFO - PROCESS | 18167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.00 stddev:4.22 (6.0%) stddev-sans-first:4.18 01:46:07 INFO - PROCESS | 18167 | Values: 75.0 69.0 68.0 68.0 70.0 81.0 67.0 70.0 70.0 69.0 01:46:07 INFO - PROCESS | 18167 | -------- Summary: end -------- 01:46:07 INFO - PROCESS | 18167 | 01:46:08 INFO - TEST-INFO | 18167: exit 0 01:46:08 INFO - TEST-OK | kraken | took 63380ms 01:46:08 INFO - SUITE-END | took 1180s 01:46:08 INFO - Completed test suite (00:19:41) 01:46:08 INFO - javascript benchmark 01:46:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.201067669024, 2595.5068536977974, 2620.5283049051177, 2620.7117217106115, 2627.671541057368, 4514.548545145484, 4548.613367863732, 4550.658700597456, 4585.4038974933255, 4590.036092420587, 4519.932201016987, 4531.592156705896, 4564.475085365184, 4613.354130421743, 4625.722456652603, 4155.916881662365, 4201.3697945308295, 4233.23801715691, 4259.87220383389, 4384.232759267132, 4330.653547716175, 4352.521222665504, 4357.0, 4364.694471386988, 4403.383526306304, 4151.5640857709805, 4203.033302340479, 4205.0, 4231.196072746184, 4267.338562522814, 4257.020885196392, 4265.7440553566885, 4268.466441694788, 4311.310190369557, 4356.695031347807, 4286.849960251377, 4291.334843099325, 4296.419983302246, 4307.978460107711, 4345.174416860818, 4325.134973005412, 4387.714798538085, 4424.867253982386, 4565.360849481042, 4606.216943119644, 4784.067106914154, 4868.853934381974, 4869.634777391674, 4870.342503761982, 4871.634627402959, 4843.782029808632, 4847.878803029953, 4858.368412106439, 4894.070126675921, 4896.216605343128, 4472.195004899149, 4564.7717614119165, 4572.611328037087, 4611.146937816515, 4618.907621847544, 5041.773120209599, 5062.519060689228, 5071.721055341918, 5090.567301779391, 5103.055934652027, 4757.238841785298, 4758.690685105457, 4789.976050119727, 4795.496472870298, 4804.0, 4764.761761911891, 4777.140114779373, 4813.687110337887, 4835.468098509161, 4875.780589873464, 4769.9046019080115, 4788.592969597623, 4797.232442809134, 4830.154722923475, 4848.636352273594, 4794.065157294364, 4794.856154315376, 4797.808087676523, 4806.855794326176, 4845.781939812717, 4102.589741025933, 4137.40007698882, 4142.502899652061, 4150.06623509714, 4190.769507677107, 3704.9629503705155, 3704.9629503705155, 3710.239400922804, 3711.536057992751, 3712.331780279522, 4166.020985068507, 4178.310578754472, 4213.0, 4218.704690671623, 4221.176870510221, 4828.203346447796, 4861.1006963711825, 4867.221244600847, 4871.391076115486, 4921.237208232729, 4197.24449599069, 4197.244495990751, 4200.537940826506, 4235.512916014698, 4240.109576988867, 4329.545397733255, 4350.108227813291, 4365.9126817463475, 4406.27296496081, 4407.757573333433, 4575.519570445055, 4577.5880170784785, 4584.61030812378, 4590.311453282035, 4622.791974361095, 4783.210770222874, 4829.710217386968, 4832.395950506187, 4838.129136755418, 4868.634852386014, 4547.590716835501, 4571.634269258385, 4579.908401832011, 4591.47198072226, 4614.307853821953, 4822.180229360947, 4823.807047718193, 4825.734584597881, 4825.782839772149, 4850.393700787402, 4877.463479017376, 4884.609231261419, 4886.755662216804, 4888.095702295087, 4939.6542242042715, 4590.609798167193, 4686.062787442457, 4714.717116972993, 4735.881602959954, 4751.809927602995, 4719.905601888012, 4727.527247275245, 4749.026449577897, 4753.809847606057, 4803.303520989507, 4583.197940360357, 4687.437507499122, 4701.059788042337, 4747.572718455355, 4750.572448479654, 4726.078414709099, 4801.95198048015, 4802.495737947465, 4803.95196048049, 4809.807607695653, 4621.098885717252, 4643.094596553775, 4644.164050470948, 4648.930266045944, 4694.694844835075], "value": 4488.3122223910495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.581206061787, 609.7348002893996, 617.4566381584206, 629.9275583307918, 634.8698516804055, 42080.0, 43266.351004734955, 43313.35029974549, 47514.28728569074, 47580.99999999991, 42672.35991460131, 43115.35326970098, 43131.0, 43147.35278970818, 43150.7842460788, 7887.211278872095, 7961.96019019907, 7983.281504664579, 8015.1984801519675, 8023.638936247883, 7848.6860525579195, 7928.246816552418, 7931.524108553505, 7931.722389716361, 7933.167017463141, 7924.0, 7952.4830885992515, 7953.761387158365, 7980.321672657831, 7990.680372785082, 7933.365330773524, 7969.242921922408, 7972.123066462714, 7976.082750483711, 7976.6809327626825, 7876.921230787733, 7948.046234451903, 7949.64226609804, 7954.562499062549, 7954.9204507954755, 39643.40534891979, 40027.7998610008, 40052.59947400547, 40057.79971100126, 40068.79965600153, 3325.534425180477, 3375.3249350130072, 3763.6612704856693, 3973.4635824163656, 4001.3197756381487, 29593.26016849596, 29742.70257297421, 29989.400211995857, 31607.0, 31696.841515792505, 3321.983390083058, 3352.094934367707, 3372.392969265531, 3381.374445727524, 3405.8590372225335, 204969.0, 258745.0, 259027.70486147638, 259120.0, 259587.63711265888, 52043.219351709755, 58620.41379586235, 58799.41200588025, 59446.70276648676, 59452.0, 56752.0, 62334.68832655808, 62533.374666253665, 62576.68711656413, 62643.6867815658, 15740.449084282223, 16097.919510402373, 16105.114218717848, 16109.516714498584, 16121.838781612269, 11046.281991670516, 11297.20919535641, 11515.25150865191, 11749.941250293694, 11914.940425297818, 19626.411207663794, 19829.30597429083, 19904.402867913985, 19915.302964396178, 19945.401637950596, 7238.348548630648, 7314.414846812242, 7364.521306115085, 7453.291937265951, 7470.3276705096805, 895.3508706187962, 984.07988530724, 1042.6819819954987, 1044.498640652491, 1109.7835921995295, 28760.137195884156, 28765.712342876304, 28936.710632893824, 29280.121596352143, 29288.414231715247, 998.9100980911608, 1007.7480629842539, 1057.6509751781894, 1063.1335461598771, 1085.8696956365286, 14988.0, 15468.226588670746, 15673.529794106194, 15687.68624627501, 15791.21043947798, 357423.0, 360329.0, 361164.0, 361367.0, 362896.0, 51158.0, 51453.74273128685, 51548.742256288475, 51582.74208628933, 51683.0, 1190.1847234644124, 1280.1742875845027, 1295.2681734819796, 1313.848907375645, 1328.110166188656, 28814.135575932756, 29593.85203073971, 29754.256143596584, 30154.0, 30495.08514744561, 38665.42001869918, 38747.806260968515, 39073.41389879211, 39077.41383879187, 39120.21759564849, 274574.0, 274677.0, 275798.0, 275878.0, 276056.9577216889, 23425.531489370456, 24059.879700601385, 25489.49021019606, 26161.215163545123, 26215.34461638398, 42916.0, 43189.78405107954, 43355.566444336415, 43516.0, 44497.55502445064, 36760.63239367679, 36921.44617830681, 37156.25687486289, 37359.0, 37778.811105944296, 34240.48639270363, 36582.8170859144, 36812.815935920145, 36947.630523695494, 37255.81372093122, 32454.0, 37886.62113378831, 38111.23777524378, 39027.0, 42458.787706061274, 32247.618857251142, 34505.82747086249, 34509.48235776415, 34531.0, 34632.480512792834, 25515.617265740657, 25922.75965504312, 26114.86942565351, 26131.346716332242, 26466.073687421616], "value": 18232.515674468752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.3916802699693, 382.93298672732266, 387.0710295291301, 394.5167170216487, 406.080228282939, 13795.724085518284, 14412.0, 15437.382504699812, 18356.632867342647, 18386.816131838696, 16563.25465354059, 17328.480145595622, 17451.21469533871, 18549.165287562057, 18582.535436614093, 4522.937109779199, 5104.132297509414, 5274.894502109955, 5289.153735402337, 5290.338707661543, 5219.765110570033, 5238.580913526908, 5257.474252574751, 5279.366476022883, 5279.841604751864, 5026.748662566857, 5224.869378265555, 5232.633715639888, 5238.711870847102, 5242.737863106849, 5178.844634660966, 5208.635395522315, 5214.322138122057, 5233.973830130844, 5243.947560524384, 4539.251023581105, 4612.238980568202, 4665.393498845162, 4676.321933319684, 4679.15775160471, 20603.175872965065, 21256.681149782766, 21578.24476143343, 21579.46051348713, 21617.135314587398, 1977.9109940052733, 2038.6738121900573, 2235.284708893155, 2256.763039880822, 2428.162284012013, 13239.602811915658, 13392.665183370396, 13427.66430839227, 13695.657608559866, 13760.380782864795, 1767.4874286456911, 1767.5757818123686, 1797.379903933141, 1830.533214030427, 1840.9263629454806, 69147.0, 69933.0, 70022.29977700209, 70247.0, 71060.0, 9447.90552094484, 9772.706818795448, 9869.555869985868, 9874.456904870302, 10027.649032283834, 11905.226160299553, 12170.57402990891, 13633.590992270249, 13692.589222323346, 13721.176729396268, 7002.614856182959, 7339.412846972229, 7421.703131874665, 7446.069241344832, 7581.241875812485, 7185.389241914391, 7194.604296763729, 7357.5953322567775, 7359.926400736032, 7381.594012329266, 6032.276126864716, 6159.137720719103, 6253.906191407133, 6267.2165979252595, 6291.622502649764, 1746.3538490758247, 1766.1787268920014, 1796.9191386387645, 1818.6362727454562, 1865.4590168851153, 931.6739141300491, 936.0, 959.1511512311655, 978.1538968791943, 1076.3649446826253, 16279.837201628068, 16942.40701575439, 16953.0, 17650.646987060187, 17892.28430862751, 941.3598752848129, 965.1795973422535, 971.965981190669, 974.6880998080546, 979.7354714227118, 9991.700248992542, 10293.897061029444, 10301.742456438498, 10319.380837149645, 10322.174226061898, 370458.0, 370878.0, 376995.0, 377057.0, 379217.0, 69037.3096269041, 83482.58258708668, 85768.0, 86552.56723716341, 87093.0, 439.9802008909607, 456.50013235507066, 456.5388957153233, 457.1725177428798, 458.0701176611484, 9735.513224338896, 10117.19062475015, 10377.688669339932, 10496.107830834158, 10503.159747220052, 24770.876145619157, 31181.68818311788, 32687.019389418354, 33910.321793564486, 37287.81356093202, 46058.30912536247, 46307.305390419846, 46549.3017604743, 46637.53362466468, 46980.53019469762, 7569.545827250383, 7589.0, 7597.886031709419, 7720.652570634447, 7733.419993500623, 9716.611335546782, 11443.771124577628, 11571.942140289244, 11793.233439826385, 11963.521459141537, 10139.89860101419, 10167.339122956984, 10466.895331046897, 10543.789124217627, 10692.358458492516, 9881.85177222328, 10188.949055254676, 10530.262881598215, 10632.0, 10704.946475267574, 10398.064174224357, 10475.109615682752, 10492.947535262274, 10684.626038088629, 10743.785124297627, 7657.617119143909, 7831.177726338652, 7882.330001949898, 7979.640916158671, 8101.0, 8054.758357249292, 9400.529973501434, 10227.846582301123, 10508.159347252355, 10584.153267738408], "value": 8142.474744808281, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.689994401344, 1528.4039224702365, 1553.0215963942715, 1734.2802736864203, 1854.5675834754938, 7000.754973575926, 7247.42020638349, 7303.634818259079, 7508.9624551877305, 7518.924810751904, 7428.257174282569, 7467.626618669058, 7550.509216900911, 7559.281868222523, 7571.356434703057, 2200.966985495219, 2228.9888550557225, 2229.6209644360497, 2230.609643312414, 2230.6654001899765, 2248.067052173354, 2265.0, 2305.4121199094207, 2307.9538409231805, 2312.5952958232324, 2189.7956124131665, 2203.2398822406244, 2220.9000594973263, 2229.2532001779423, 2234.82121430286, 2150.5698860227862, 2166.6100101981638, 2183.1376606240524, 2184.552166805817, 2187.846850720442, 2168.479564904427, 2176.5320456101854, 2176.62997290461, 2176.847620666554, 2176.880271585062, 7410.03669522964, 7464.813379665497, 7466.365358944442, 7470.103587569526, 7648.311651951351, 4599.655025873073, 4765.666403351766, 4788.760561971888, 4795.6882802618065, 4799.016201678647, 2959.8520073996215, 2984.880604775806, 2989.3274013346822, 2997.5054116070824, 3047.3143542702937, 927.9907200927972, 928.4522131942119, 931.180561106229, 946.6592026870321, 953.427943234061, 10689.144868410509, 10775.137988960865, 10783.5686572537, 10785.514651840685, 10830.458477076114, 4069.4709687740406, 4173.52004519478, 4190.559991200941, 4213.9578604214175, 4246.702730808814, 8453.239208471266, 8595.699150529701, 8600.0109987351, 8618.741437756877, 8624.482531048157, 4629.791659375336, 4635.58279754817, 4640.373549570765, 4641.373414589055, 4642.37327960721, 3759.9436008459893, 4168.583141685807, 4215.473065866767, 4281.293586558245, 4314.50383205929, 3374.4938259261307, 3375.6159974410375, 3447.1899103710607, 3466.341395134916, 3468.150303175738, 969.1132613658565, 1036.3678156324636, 1036.657902892044, 1040.8022475729588, 1041.7031146123318, 643.5173619785161, 751.9887201691979, 841.6927821345165, 844.5523872347666, 904.6200595749801, 5186.818461353834, 5239.921401178985, 5299.708516031578, 5392.379876314196, 5480.862978425492, 913.8439873559952, 957.3490026781856, 957.5690939077443, 963.2967933408651, 965.6861520005885, 3700.925981480409, 3709.7774133552075, 3759.567649720317, 3785.772853628736, 3795.411711184771, 9314.161725444743, 9435.764105897408, 9627.326087173831, 9799.706008819747, 9802.852957205647, 9573.32986690925, 9607.51962401877, 9617.663381781744, 9731.513424328756, 9748.61005559784, 7034.718611255493, 7176.0, 7181.676824542908, 7418.925810741824, 7463.253674632602, 5232.215167724872, 5311.681299122065, 5340.145576707863, 5347.465253474621, 5357.758900849393, 8340.541270230196, 8511.404201705822, 8517.829643407222, 8529.104444033288, 8546.059933407196, 8551.1448855114, 8570.057293697813, 8608.311335093053, 8670.219680228809, 8719.738407847775, 5854.443827836349, 6307.3377295383325, 6490.610563366213, 6843.349881761224, 6989.685464154227, 7129.25142860013, 7156.463265255231, 7185.419207774281, 7203.8919416207755, 7222.927770722225, 6314.084457753692, 6453.967730161319, 6481.027845822976, 6565.573237739723, 6577.309382514767, 6396.296407395276, 6405.167328247298, 6410.711517981609, 6468.320826313169, 6504.0, 6241.21984751906, 6254.718537665725, 6287.276963149114, 6287.842803929939, 6292.653904035139, 4552.908941821212, 4567.2007398705755, 4609.700369475973, 4654.069186162713, 4662.370579971661, 4321.654267658642, 4348.695591308578, 4358.6295164911335, 4418.867433976986, 4444.266695995125], "value": 4104.121980462597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.2540252588735, 310.8135118928643, 313.0654994840401, 316.45569620253156, 317.57603599195073, 4631.884202894929, 4635.374224479694, 4684.648651351154, 4689.718616882989, 4730.19586670266, 4608.861734147972, 4625.930611040837, 4630.328602352657, 4650.953490465095, 4692.741899195551, 3522.172289511963, 3618.8190590470504, 3641.1443310821937, 3716.2905063670746, 3735.8505659773577, 3673.687736542397, 3703.962960370389, 3713.4589145504583, 3713.591504934455, 3724.9068773280615, 3490.5287786148797, 3636.8545258189774, 3652.6485200475727, 3682.466042423847, 3688.3360995020885, 3576.4635304704243, 3662.450632405134, 3724.42271447926, 3731.104534911629, 3734.7012239020814, 3315.4529502632035, 3317.5355450236984, 3320.634730179678, 3332.800031998064, 3334.3831391192707, 4432.180046691373, 4445.9110817783785, 4482.260427029536, 4484.8206071757095, 4499.6400287976885, 3930.6658933990643, 4156.251874662559, 4161.063760653859, 4225.429567008446, 4274.166537525184, 4850.490698476645, 4864.756762161913, 4869.245266983623, 4872.537108974641, 4875.268709693539, 3503.7722548034294, 3506.982465087658, 3510.6313837046996, 3521.753477256593, 3545.8936231913085, 4855.36880205571, 4966.528179822947, 5123.564497017758, 5147.794088236466, 5150.150225212836, 3550.1657110578994, 3569.8929032129076, 3583.283343331344, 3584.121890136881, 3587.515685382492, 3629.764065335745, 3639.0, 3641.9271614568092, 3648.5074514940675, 3651.214988777426, 4156.56356082613, 4160.583941605815, 4172.248995180897, 4174.269502836992, 4178.185253875465, 4678.321643361762, 4868.878278043077, 4870.611875615433, 4880.682755620874, 4901.411830580282, 1217.6301660631789, 1229.059769276504, 1234.8950339221087, 1236.2891337480985, 1239.4484454417877, 799.5842162075688, 832.76682528892, 840.2269911681268, 845.7124577643508, 847.6948298612494, 4131.814068366871, 4138.255114079495, 4138.482689663792, 4178.498580170338, 4190.874273771792, 4769.523047695272, 4796.712197268175, 4829.758512074382, 4836.395450568679, 4858.902821943541, 4021.4369988201674, 4138.441310423114, 4169.207850508394, 4175.728577642443, 4176.2691528982305, 2541.1995221505167, 2542.453372524879, 2549.2155491156263, 2556.2714626331776, 2557.1689201009744, 4537.8184872604725, 4554.88612784683, 4573.931391029138, 4584.839530616479, 4587.564181402761, 4640.79116439761, 4882.218844984856, 4884.145274576935, 4899.191633380452, 4909.134528879074, 4566.908661826745, 4571.382863313476, 4621.907561848744, 4622.560856718606, 4643.3731446255, 4876.4392094909535, 4891.951080489292, 4896.4124305083615, 4904.852854414374, 4923.187674033744, 4505.481869584909, 4643.860684179345, 4668.673192876466, 4739.976300118477, 4752.287156926489, 4463.464384273908, 4512.210363186364, 4530.818767249273, 4562.543745625411, 4634.9536504634525, 3426.9657303426648, 3481.7388695848417, 3485.407480728333, 3491.4064609017037, 3499.757586056913, 4784.856454306377, 4837.250226214942, 4848.5636292733825, 4868.148074087091, 4875.268709693574, 4446.355278484666, 4692.639134650913, 4725.385699858996, 4733.21342925665, 4737.928931066106, 4697.459792123813, 4707.2939059140035, 4711.858644240679, 4714.292856071616, 4719.504452032487, 4592.793324300348, 4624.075184962953, 4635.976820115878, 4645.3032045193495, 4648.814047438064, 4501.437320334958, 4714.575688187942, 4731.834385796618, 4743.762811859324, 4869.391326084239, 4755.714657120584, 4766.928496072631, 4782.832600858953, 4795.280707893844, 4796.424429068395], "value": 3636.126143877929, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7632757517597, 764.6024067484908, 795.8937077462328, 823.7623762376238, 839.3788596438637, 11435.42822858857, 11487.942560287207, 11513.136514761385, 11565.942170289136, 11629.302241865484, 12620.24278543288, 12685.112042157052, 12704.555340563082, 13231.536896208634, 13812.171269723824, 682.5802131689026, 883.5935469683938, 890.568074483878, 891.5453118909338, 891.9821603567925, 851.3231980575426, 872.0233338660709, 877.2411863737884, 885.2077390735288, 885.6900084970241, 929.9674511392069, 932.3520153493325, 933.3000249812641, 933.7572231219864, 934.3319526538523, 712.3410844968383, 886.4459712679575, 919.8252332056921, 921.2261700171854, 922.0364718868731, 676.455453360045, 678.7285085965603, 679.5956405938458, 679.7926632377123, 680.0649107477219, 13183.143095698844, 13225.86774132256, 13264.3367831609, 13286.20282783036, 13288.335583220896, 11682.0, 12133.0, 12292.0, 12306.323152226623, 12388.132830701854, 9776.51117444125, 9916.752081197956, 9948.90051099487, 10009.19926405893, 10422.21833362501, 3325.1354647791504, 3341.899743007714, 3384.729221662261, 3403.880864169767, 3481.54739883816, 43155.56844431547, 43599.56400436018, 43615.563844361466, 44708.329375059075, 44927.0, 9528.659876173413, 9574.090461406295, 9610.51947402627, 9616.912812054989, 9773.804523909625, 16532.917335413247, 16551.25519351632, 16605.252763625667, 16646.91676541634, 16648.75026874598, 6728.899066514006, 6755.459563235027, 6766.763163289262, 6889.173299204027, 6926.58440493572, 3775.5091838061426, 3784.2242340320167, 3798.924021519554, 3840.0591854995705, 3855.5373355196994, 2879.1074766822353, 2978.4638765022505, 2980.1208643450236, 2980.716831900966, 2981.4037192561573, 503.04923694217956, 515.6905856486078, 516.1715446708055, 520.4639221601756, 527.6412039812964, 620.9316975132732, 634.7016902056026, 635.3138610300956, 650.0801366067057, 654.7446495866616, 7848.13670496245, 7875.369970402354, 7907.644156012878, 7987.56068416231, 8103.88837947008, 515.5385929592993, 584.7310237290894, 612.4426771637877, 617.2623714661026, 639.8528338482175, 3573.5610222115906, 3647.963520364762, 3740.7194460415576, 3835.1562656215588, 3896.1428485733095, 46012.30981535213, 47288.0, 47397.289040664415, 47752.76123619429, 49795.50204497909, 44193.77903110464, 44683.776581117534, 45564.0, 45574.544254557695, 46124.30813537799, 40575.59424405777, 40628.59371406307, 41370.37944430836, 41830.0, 41881.79059104685, 7959.323457506177, 8009.3192078673965, 8014.118446970945, 8050.235227653364, 8092.514449133071, 29655.406891862473, 29923.70076299209, 30009.249768755955, 30112.84943575268, 30918.0, 34512.65487345094, 35880.4617930726, 37475.43786843254, 37600.0, 38024.619753803214, 10864.891351086704, 10867.13062954946, 10931.234813563293, 11165.330080195214, 11219.382933938712, 11120.777584448104, 11236.213465057694, 11890.0, 12320.260784352968, 12591.559295424617, 11270.549178032787, 11481.712957176138, 11521.654350369503, 11911.106666999836, 11911.880881191077, 10793.190510711886, 11384.829227561428, 11737.0, 11779.411029448322, 11840.171188016757, 11083.279586827153, 11591.130665199975, 11986.460609272777, 12080.275183488668, 12091.818622720843, 8888.822223555622, 9287.164155226063, 9402.15380615748, 9444.291678124306, 9648.653914364166, 8716.3462740296, 9160.587773550073, 9508.239340852853, 9903.405795652285, 10147.289689721649], "value": 6026.6370781653295, "unit": "score"}], "name": "dromaeo_css", "value": 6255.746857692066, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 113.0, 112.0, 115.0, 115.0, 113.0, 112.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 130.0, 163.0, 189.0, 131.0, 152.0, 153.0, 141.0, 199.0, 140.0], "value": 156.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 124.0, 76.0, 75.0, 77.0, 76.0, 131.0, 76.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 125.0, 92.0, 94.0, 94.0, 121.0, 93.0, 93.0, 127.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 66.0, 67.0, 69.0, 94.0, 67.0, 64.0], "value": 69.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 67.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 81.0, 82.0, 85.0, 89.0, 84.0, 88.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 135.0, 138.0, 129.0, 139.0, 132.0, 130.0, 222.0, 134.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 177.0, 174.0, 172.0, 173.0, 185.0, 174.0, 176.0, 172.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 69.0, 68.0, 68.0, 70.0, 81.0, 67.0, 70.0, 70.0, 69.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1584.7000000000003, "alertThreshold": 2.0}]} 01:46:08 INFO - Return code: 0 01:46:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:46:08 ERROR - # TBPL SUCCESS # 01:46:08 INFO - Running post-action listener: _resource_record_post_action 01:46:08 INFO - ##### 01:46:08 INFO - ##### Finished run-tests step (success) 01:46:08 INFO - ##### 01:46:08 INFO - Running post-run listener: _resource_record_post_run 01:46:09 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 16384; Write bytes: 533090304; Read time: 496; Write time: 462396 01:46:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 249819136; Read time: 200; Write time: 262532 01:46:09 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 283271168; Read time: 296; Write time: 199864 01:46:09 INFO - Running post-run listener: _upload_blobber_files 01:46:09 INFO - Blob upload gear active. 01:46:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:46:09 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 01:46:09 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'] 01:46:09 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 01:46:10 INFO - (blobuploader) - INFO - Open directory for files ... 01:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:11 INFO - (blobuploader) - INFO - Done attempting. 01:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:11 INFO - (blobuploader) - INFO - Done attempting. 01:46:11 INFO - (blobuploader) - INFO - Iteration through files over. 01:46:11 INFO - Return code: 0 01:46:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:46:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:46:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28444613141b8e15276f9b57346dc5adc8e1ca4a32128f5d2b2302b3c267270aa9bc110e79e7adb6c3874e06577d8cc08a9e0d105369febf0f968a8d0cd96e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad438a0df2f5b42cb4b138f13777229ae4b50ab0339373e31a728e3974ea5ac324f0183f4bf428b8b0d19f53f35a5c72ad4ead825bc9de2d81006f9efd0b658c"} 01:46:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:46:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:46:11 INFO - Contents: 01:46:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28444613141b8e15276f9b57346dc5adc8e1ca4a32128f5d2b2302b3c267270aa9bc110e79e7adb6c3874e06577d8cc08a9e0d105369febf0f968a8d0cd96e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad438a0df2f5b42cb4b138f13777229ae4b50ab0339373e31a728e3974ea5ac324f0183f4bf428b8b0d19f53f35a5c72ad4ead825bc9de2d81006f9efd0b658c"} 01:46:11 INFO - Running post-run listener: copy_logs_to_upload_dir 01:46:11 INFO - Copying logs to upload dir... 01:46:11 INFO - mkdir: /builds/slave/test/build/upload/logs 01:46:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.879328 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-08 01:46:11.508083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 01:46:11.512060) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078 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/28444613141b8e15276f9b57346dc5adc8e1ca4a32128f5d2b2302b3c267270aa9bc110e79e7adb6c3874e06577d8cc08a9e0d105369febf0f968a8d0cd96e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad438a0df2f5b42cb4b138f13777229ae4b50ab0339373e31a728e3974ea5ac324f0183f4bf428b8b0d19f53f35a5c72ad4ead825bc9de2d81006f9efd0b658c"} build_url:https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/XfeH_VBWQs-fzA3ICbB9SA/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/28444613141b8e15276f9b57346dc5adc8e1ca4a32128f5d2b2302b3c267270aa9bc110e79e7adb6c3874e06577d8cc08a9e0d105369febf0f968a8d0cd96e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad438a0df2f5b42cb4b138f13777229ae4b50ab0339373e31a728e3974ea5ac324f0183f4bf428b8b0d19f53f35a5c72ad4ead825bc9de2d81006f9efd0b658c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 01:46:11.537939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 01:46:11.538321) ========= 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=4ac8d263c7293b36a1be1aed000001be-1462695850.689960-821954078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 01:46:11.623884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 01:46:11.624305) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 01:46:11.624679) ========= ========= Total master_lag: 0.19 =========