builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1462831362.41 results: success (0) buildid: 20160509142802 builduid: a4d3cdb17fab4cf5b05b6a4ff252e1a3 revision: a3033ed384eb846bf37d9a4bf59a3728f15e9f74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.407259) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.407726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.408009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.468471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.468881) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 15:02:42-- 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% 50.5M=0s 2016-05-09 15:02:42 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.570812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.571135) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018871 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.620617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:42.620988) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3033ed384eb846bf37d9a4bf59a3728f15e9f74 --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 a3033ed384eb846bf37d9a4bf59a3728f15e9f74 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 15:02:42,817 truncating revision to first 12 chars 2016-05-09 15:02:42,817 Setting DEBUG logging. 2016-05-09 15:02:42,817 attempt 1/10 2016-05-09 15:02:42,817 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3033ed384eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 15:02:43,072 unpacking tar archive at: fx-team-a3033ed384eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:43.155574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:43.155927) ========= script_repo_revision: a3033ed384eb846bf37d9a4bf59a3728f15e9f74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:43.156315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:43.156582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 15:02:43.164194) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-09 15:02:43.164466) ========= /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=a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:02:43 INFO - MultiFileLogger online at 20160509 15:02:43 in /builds/slave/test 15:02:43 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 15:02:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:02:43 INFO - {'append_to_log': False, 15:02:43 INFO - 'base_work_dir': '/builds/slave/test', 15:02:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:02:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:02:43 INFO - 'branch': 'Fx-Team-Non-PGO', 15:02:43 INFO - 'buildbot_json_path': 'buildprops.json', 15:02:43 INFO - 'config_files': ('talos/linux_config.py',), 15:02:43 INFO - 'default_actions': ('clobber', 15:02:43 INFO - 'read-buildbot-config', 15:02:43 INFO - 'download-and-extract', 15:02:43 INFO - 'populate-webroot', 15:02:43 INFO - 'create-virtualenv', 15:02:43 INFO - 'install', 15:02:43 INFO - 'run-tests'), 15:02:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:02:43 INFO - 'download_minidump_stackwalk': True, 15:02:43 INFO - 'download_symbols': 'ondemand', 15:02:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:02:43 INFO - 'tooltool.py': '/tools/tooltool.py', 15:02:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:02:43 INFO - '/tools/misc-python/virtualenv.py')}, 15:02:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:02:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:02:43 INFO - 'installer_path': 'installer.exe', 15:02:43 INFO - 'log_level': 'info', 15:02:43 INFO - 'log_name': 'talos', 15:02:43 INFO - 'log_to_console': True, 15:02:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:02:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:02:43 INFO - 'opt_config_files': (), 15:02:43 INFO - 'pip_index': False, 15:02:43 INFO - 'sps_profile': False, 15:02:43 INFO - 'sps_profile_interval': 0, 15:02:43 INFO - 'suite': 'dromaeojs', 15:02:43 INFO - 'system_bits': '32', 15:02:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:02:43 INFO - 'title': 'talos-linux64-ix-002', 15:02:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:02:43 INFO - 'use_talos_json': True, 15:02:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:02:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:02:43 INFO - 'work_dir': 'build'} 15:02:43 INFO - ##### 15:02:43 INFO - ##### Running clobber step. 15:02:43 INFO - ##### 15:02:43 INFO - Running pre-action listener: _resource_record_pre_action 15:02:43 INFO - Running main action method: clobber 15:02:43 INFO - rmtree: /builds/slave/test/build 15:02:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:02:43 INFO - Running post-action listener: _resource_record_post_action 15:02:43 INFO - ##### 15:02:43 INFO - ##### Finished clobber step (success) 15:02:43 INFO - ##### 15:02:43 INFO - ##### 15:02:43 INFO - ##### Running read-buildbot-config step. 15:02:43 INFO - ##### 15:02:43 INFO - Running pre-action listener: _resource_record_pre_action 15:02:43 INFO - Running main action method: read_buildbot_config 15:02:43 INFO - Using buildbot properties: 15:02:43 INFO - { 15:02:43 INFO - "project": "", 15:02:43 INFO - "product": "firefox", 15:02:43 INFO - "script_repo_revision": "production", 15:02:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:02:43 INFO - "repository": "", 15:02:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:02:43 INFO - "buildid": "20160509142802", 15:02:43 INFO - "pgo_build": "False", 15:02:43 INFO - "basedir": "/builds/slave/test", 15:02:43 INFO - "buildnumber": 2941, 15:02:43 INFO - "slavename": "talos-linux64-ix-002", 15:02:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:02:43 INFO - "platform": "ubuntu64_hw", 15:02:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:02:43 INFO - "branch": "fx-team", 15:02:43 INFO - "repo_path": "integration/fx-team", 15:02:43 INFO - "revision": "a3033ed384eb846bf37d9a4bf59a3728f15e9f74", 15:02:43 INFO - "stage_platform": "linux64", 15:02:43 INFO - "builduid": "a4d3cdb17fab4cf5b05b6a4ff252e1a3", 15:02:43 INFO - "slavebuilddir": "test" 15:02:43 INFO - } 15:02:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:02:43 INFO - Running post-action listener: _resource_record_post_action 15:02:43 INFO - ##### 15:02:43 INFO - ##### Finished read-buildbot-config step (success) 15:02:43 INFO - ##### 15:02:43 INFO - ##### 15:02:43 INFO - ##### Running download-and-extract step. 15:02:43 INFO - ##### 15:02:43 INFO - Running pre-action listener: _resource_record_pre_action 15:02:43 INFO - Running main action method: download_and_extract 15:02:43 INFO - mkdir: /builds/slave/test/build/tests 15:02: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')]} 15:02:43 INFO - https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:44 INFO - Downloaded 1361 bytes. 15:02:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:02:44 INFO - Using the following test package requirements: 15:02:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:02:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:02:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:44 INFO - u'jsshell-linux-x86_64.zip'], 15:02:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:02:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:02:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:02:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:02:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:02:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:02:44 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')]} 15:02:44 INFO - https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:45 INFO - Downloaded 22322863 bytes. 15:02:45 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'] 15:02:45 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 15:02:46 INFO - Return code: 0 15:02:46 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 15:02:46 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')]} 15:02:46 INFO - https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:47 INFO - Downloaded 22322863 bytes. 15:02:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:02:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:02:49 INFO - Return code: 0 15:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:49 INFO - https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:50 INFO - Downloaded 10840152 bytes. 15:02:50 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'] 15:02:50 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 15:02:50 INFO - Return code: 0 15:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:50 INFO - https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:02:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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 15:02:52 INFO - Downloaded 54859095 bytes. 15:02:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:52 INFO - mkdir: /builds/slave/test/properties 15:02:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:02:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:02:52 INFO - Contents: 15:02:52 INFO - build_url:https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:53 INFO - Running post-action listener: _resource_record_post_action 15:02:53 INFO - Running post-action listener: set_extra_try_arguments 15:02:53 INFO - ##### 15:02:53 INFO - ##### Finished download-and-extract step (success) 15:02:53 INFO - ##### 15:02:53 INFO - ##### 15:02:53 INFO - ##### Running populate-webroot step. 15:02:53 INFO - ##### 15:02:53 INFO - Running pre-action listener: _resource_record_pre_action 15:02:53 INFO - Running main action method: populate_webroot 15:02:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:02:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:02:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:02:53 INFO - '--tppagecycles', 15:02:53 INFO - '7'], 15:02:53 INFO - 'tests': ['tsvgm']}}, 15:02:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:02:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:02:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:02:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:02:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:53 INFO - 'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:53 INFO - 'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['damp', 'tps']}, 15:02:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:53 INFO - 'tests': ['damp', 'tps']}, 15:02:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['dromaeo_dom']}, 15:02:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:02:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['a11yr', 15:02:53 INFO - 'ts_paint', 15:02:53 INFO - 'tpaint', 15:02:53 INFO - 'sessionrestore', 15:02:53 INFO - 'sessionrestore_no_auto_restore', 15:02:53 INFO - 'tabpaint']}, 15:02:53 INFO - 'other-e10s': {'tests': ['a11yr', 15:02:53 INFO - 'ts_paint', 15:02:53 INFO - 'tpaint', 15:02:53 INFO - 'sessionrestore', 15:02:53 INFO - 'sessionrestore_no_auto_restore', 15:02:53 INFO - 'tabpaint']}, 15:02:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:02:53 INFO - 'ts_paint', 15:02:53 INFO - 'tpaint', 15:02:53 INFO - 'sessionrestore', 15:02:53 INFO - 'sessionrestore_no_auto_restore', 15:02:53 INFO - 'tabpaint']}, 15:02:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:02:53 INFO - 'ts_paint', 15:02:53 INFO - 'tpaint', 15:02:53 INFO - 'sessionrestore', 15:02:53 INFO - 'sessionrestore_no_auto_restore', 15:02:53 INFO - 'tabpaint']}, 15:02:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['a11yr', 15:02:53 INFO - 'ts_paint', 15:02:53 INFO - 'tpaint', 15:02:53 INFO - 'sessionrestore', 15:02:53 INFO - 'sessionrestore_no_auto_restore', 15:02:53 INFO - 'tabpaint']}, 15:02:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['a11yr', 15:02:53 INFO - 'ts_paint', 15:02:53 INFO - 'tpaint', 15:02:53 INFO - 'sessionrestore', 15:02:53 INFO - 'sessionrestore_no_auto_restore', 15:02:53 INFO - 'tabpaint']}, 15:02:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['tsvgx', 15:02:53 INFO - 'tsvgr_opacity', 15:02:53 INFO - 'tart', 15:02:53 INFO - 'tscrollx', 15:02:53 INFO - 'cart']}, 15:02:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:02:53 INFO - 'tsvgr_opacity', 15:02:53 INFO - 'tart', 15:02:53 INFO - 'tscrollx', 15:02:53 INFO - 'cart']}, 15:02:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:53 INFO - 'talos_options': ['--disable-e10s'], 15:02:53 INFO - 'tests': ['tp5o']}, 15:02:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:53 INFO - 'tests': ['tp5o']}, 15:02:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:53 INFO - 'talos_options': ['--disable-e10s', 15:02:53 INFO - '--xperf_path', 15:02:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:53 INFO - 'tests': ['tp5n']}, 15:02:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:53 INFO - 'talos_options': ['--xperf_path', 15:02:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:53 INFO - 'tests': ['tp5n']}}, 15:02:53 INFO - 'talos.zip': {'path': '', 15:02:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:02:53 INFO - Running post-action listener: _resource_record_post_action 15:02:53 INFO - ##### 15:02:53 INFO - ##### Finished populate-webroot step (success) 15:02:53 INFO - ##### 15:02:53 INFO - ##### 15:02:53 INFO - ##### Running create-virtualenv step. 15:02:53 INFO - ##### 15:02:53 INFO - Running pre-action listener: _resource_record_pre_action 15:02:53 INFO - Running main action method: create_virtualenv 15:02:53 INFO - Creating virtualenv /builds/slave/test/build/venv 15:02:53 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 15:02:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:02:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:02:53 INFO - Using real prefix '/usr' 15:02:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:02:53 INFO - Installing distribute.............................................................................................................................................................................................done. 15:02:55 INFO - Installing pip.................done. 15:02:55 INFO - Return code: 0 15:02:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:02:55 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')]} 15:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:55 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')]} 15:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:55 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 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:02:55 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 15:02:55 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 15:02:55 INFO - Using env: {'DISPLAY': ':0', 15:02:55 INFO - 'HOME': '/home/cltbld', 15:02:55 INFO - 'LANG': 'en_US.UTF-8', 15:02:55 INFO - 'LANGUAGE': 'en_US:en', 15:02:55 INFO - 'LOGNAME': 'cltbld', 15:02:55 INFO - 'MAIL': '/var/mail/cltbld', 15:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:55 INFO - 'MOZ_NO_REMOTE': '1', 15:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:55 INFO - 'NO_EM_RESTART': '1', 15:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:55 INFO - 'PWD': '/builds/slave/test', 15:02:55 INFO - 'SHELL': '/bin/bash', 15:02:55 INFO - 'SHLVL': '1', 15:02:55 INFO - 'TERM': 'linux', 15:02:55 INFO - 'TMOUT': '86400', 15:02:55 INFO - 'USER': 'cltbld', 15:02:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:55 INFO - '_': '/tools/buildbot/bin/python'} 15:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:55 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 15:02:55 INFO - Cleaning up... 15:02:55 INFO - Return code: 0 15:02:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:02:55 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')]} 15:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:55 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')]} 15:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:55 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 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:02:55 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 15:02:55 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 15:02:55 INFO - Using env: {'DISPLAY': ':0', 15:02:55 INFO - 'HOME': '/home/cltbld', 15:02:55 INFO - 'LANG': 'en_US.UTF-8', 15:02:55 INFO - 'LANGUAGE': 'en_US:en', 15:02:55 INFO - 'LOGNAME': 'cltbld', 15:02:55 INFO - 'MAIL': '/var/mail/cltbld', 15:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:55 INFO - 'MOZ_NO_REMOTE': '1', 15:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:55 INFO - 'NO_EM_RESTART': '1', 15:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:55 INFO - 'PWD': '/builds/slave/test', 15:02:55 INFO - 'SHELL': '/bin/bash', 15:02:55 INFO - 'SHLVL': '1', 15:02:55 INFO - 'TERM': 'linux', 15:02:55 INFO - 'TMOUT': '86400', 15:02:55 INFO - 'USER': 'cltbld', 15:02:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:55 INFO - '_': '/tools/buildbot/bin/python'} 15:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:56 INFO - Downloading/unpacking psutil>=0.7.1 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:02:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:58 INFO - Installing collected packages: psutil 15:02:58 INFO - Running setup.py install for psutil 15:02:58 INFO - building 'psutil._psutil_linux' extension 15:02:58 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 15:02:58 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 15:02:58 INFO - building 'psutil._psutil_posix' extension 15:02:58 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 15:02:58 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 15:02:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:58 INFO - Successfully installed psutil 15:02:58 INFO - Cleaning up... 15:02:58 INFO - Return code: 0 15:02:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:02:58 INFO - Using env: {'DISPLAY': ':0', 15:02:58 INFO - 'HOME': '/home/cltbld', 15:02:58 INFO - 'LANG': 'en_US.UTF-8', 15:02:58 INFO - 'LANGUAGE': 'en_US:en', 15:02:58 INFO - 'LOGNAME': 'cltbld', 15:02:58 INFO - 'MAIL': '/var/mail/cltbld', 15:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:58 INFO - 'MOZ_NO_REMOTE': '1', 15:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:58 INFO - 'NO_EM_RESTART': '1', 15:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:58 INFO - 'PWD': '/builds/slave/test', 15:02:58 INFO - 'SHELL': '/bin/bash', 15:02:58 INFO - 'SHLVL': '1', 15:02:58 INFO - 'TERM': 'linux', 15:02:58 INFO - 'TMOUT': '86400', 15:02:58 INFO - 'USER': 'cltbld', 15:02:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:58 INFO - '_': '/tools/buildbot/bin/python'} 15:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:03:00 INFO - Installing collected packages: mozsystemmonitor 15:03:00 INFO - Running setup.py install for mozsystemmonitor 15:03:00 INFO - Successfully installed mozsystemmonitor 15:03:00 INFO - Cleaning up... 15:03:01 INFO - Return code: 0 15:03:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:03:01 INFO - Using env: {'DISPLAY': ':0', 15:03:01 INFO - 'HOME': '/home/cltbld', 15:03:01 INFO - 'LANG': 'en_US.UTF-8', 15:03:01 INFO - 'LANGUAGE': 'en_US:en', 15:03:01 INFO - 'LOGNAME': 'cltbld', 15:03:01 INFO - 'MAIL': '/var/mail/cltbld', 15:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:01 INFO - 'MOZ_NO_REMOTE': '1', 15:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:01 INFO - 'NO_EM_RESTART': '1', 15:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:01 INFO - 'PWD': '/builds/slave/test', 15:03:01 INFO - 'SHELL': '/bin/bash', 15:03:01 INFO - 'SHLVL': '1', 15:03:01 INFO - 'TERM': 'linux', 15:03:01 INFO - 'TMOUT': '86400', 15:03:01 INFO - 'USER': 'cltbld', 15:03:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:01 INFO - '_': '/tools/buildbot/bin/python'} 15:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:03 INFO - Downloading blobuploader-1.2.4.tar.gz 15:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:03:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:03:03 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 15:03:03 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 15:03:03 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 15:03:03 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 15:03:03 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 15:03:03 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 15:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:03:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:03:03 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 15:03:03 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 15:03:03 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 15:03:03 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 15:03:03 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 15:03:03 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 15:03:03 INFO - Downloading docopt-0.6.1.tar.gz 15:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:03:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:03:03 INFO - Running setup.py install for blobuploader 15:03:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:03:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:03:03 INFO - Running setup.py install for requests 15:03:04 INFO - Running setup.py install for docopt 15:03:04 INFO - Successfully installed blobuploader requests docopt 15:03:04 INFO - Cleaning up... 15:03:04 INFO - Return code: 0 15:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:04 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 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:03:04 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 15:03:04 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 15:03:04 INFO - Using env: {'DISPLAY': ':0', 15:03:04 INFO - 'HOME': '/home/cltbld', 15:03:04 INFO - 'LANG': 'en_US.UTF-8', 15:03:04 INFO - 'LANGUAGE': 'en_US:en', 15:03:04 INFO - 'LOGNAME': 'cltbld', 15:03:04 INFO - 'MAIL': '/var/mail/cltbld', 15:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:04 INFO - 'MOZ_NO_REMOTE': '1', 15:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:04 INFO - 'NO_EM_RESTART': '1', 15:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:04 INFO - 'PWD': '/builds/slave/test', 15:03:04 INFO - 'SHELL': '/bin/bash', 15:03:04 INFO - 'SHLVL': '1', 15:03:04 INFO - 'TERM': 'linux', 15:03:04 INFO - 'TMOUT': '86400', 15:03:04 INFO - 'USER': 'cltbld', 15:03:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:04 INFO - '_': '/tools/buildbot/bin/python'} 15:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:04 INFO - Running setup.py (path:/tmp/pip-9GmVNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:04 INFO - Running setup.py (path:/tmp/pip-fTZiqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:04 INFO - Running setup.py (path:/tmp/pip-UjmnPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:04 INFO - Running setup.py (path:/tmp/pip-x4UtX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:04 INFO - Running setup.py (path:/tmp/pip-Huucad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:05 INFO - Running setup.py (path:/tmp/pip-1mFjqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:05 INFO - Running setup.py (path:/tmp/pip-WuJ0Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:05 INFO - Running setup.py (path:/tmp/pip-nuWYCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:05 INFO - Running setup.py (path:/tmp/pip-5FTLvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:05 INFO - Running setup.py (path:/tmp/pip-PfPI3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:05 INFO - Running setup.py (path:/tmp/pip-ff9DKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:05 INFO - Running setup.py (path:/tmp/pip-7lFZe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:05 INFO - Running setup.py (path:/tmp/pip-NOfOfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:05 INFO - Running setup.py (path:/tmp/pip-y_p8GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:05 INFO - Running setup.py (path:/tmp/pip-ldJWaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:05 INFO - Running setup.py (path:/tmp/pip-Q5A96d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:05 INFO - Running setup.py (path:/tmp/pip-YwVNhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:03:05 INFO - Running setup.py install for manifestparser 15:03:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:03:05 INFO - Running setup.py install for mozcrash 15:03:06 INFO - Running setup.py install for mozdebug 15:03:06 INFO - Running setup.py install for mozdevice 15:03:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Running setup.py install for mozfile 15:03:06 INFO - Running setup.py install for mozhttpd 15:03:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Running setup.py install for mozinfo 15:03:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Running setup.py install for mozInstall 15:03:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Running setup.py install for mozleak 15:03:06 INFO - Running setup.py install for mozlog 15:03:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Running setup.py install for moznetwork 15:03:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:03:06 INFO - Running setup.py install for mozprocess 15:03:07 INFO - Running setup.py install for mozprofile 15:03:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:03:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:03:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:03:07 INFO - Running setup.py install for mozrunner 15:03:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:03:07 INFO - Running setup.py install for mozscreenshot 15:03:07 INFO - Running setup.py install for moztest 15:03:07 INFO - Running setup.py install for mozversion 15:03:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:03:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:03:07 INFO - Cleaning up... 15:03:07 INFO - Return code: 0 15:03:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:07 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 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:03:07 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 15:03:07 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 15:03:07 INFO - Using env: {'DISPLAY': ':0', 15:03:07 INFO - 'HOME': '/home/cltbld', 15:03:07 INFO - 'LANG': 'en_US.UTF-8', 15:03:07 INFO - 'LANGUAGE': 'en_US:en', 15:03:07 INFO - 'LOGNAME': 'cltbld', 15:03:07 INFO - 'MAIL': '/var/mail/cltbld', 15:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:07 INFO - 'MOZ_NO_REMOTE': '1', 15:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:07 INFO - 'NO_EM_RESTART': '1', 15:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:07 INFO - 'PWD': '/builds/slave/test', 15:03:07 INFO - 'SHELL': '/bin/bash', 15:03:07 INFO - 'SHLVL': '1', 15:03:07 INFO - 'TERM': 'linux', 15:03:07 INFO - 'TMOUT': '86400', 15:03:07 INFO - 'USER': 'cltbld', 15:03:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:07 INFO - '_': '/tools/buildbot/bin/python'} 15:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:07 INFO - Running setup.py (path:/tmp/pip-NB9cNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:07 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)) 15:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:07 INFO - Running setup.py (path:/tmp/pip-UOd6u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:08 INFO - Running setup.py (path:/tmp/pip-DaMBeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:08 INFO - Running setup.py (path:/tmp/pip-vSXUYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:08 INFO - Running setup.py (path:/tmp/pip-3DxKSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:08 INFO - Running setup.py (path:/tmp/pip-BYvxXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:08 INFO - Running setup.py (path:/tmp/pip-VvLAtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:08 INFO - Running setup.py (path:/tmp/pip-BBW2OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:08 INFO - Running setup.py (path:/tmp/pip-a2WRa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:08 INFO - Running setup.py (path:/tmp/pip-Geyd2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:08 INFO - Running setup.py (path:/tmp/pip-SrSSPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:08 INFO - Running setup.py (path:/tmp/pip-GA0eTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:08 INFO - Running setup.py (path:/tmp/pip-SRmCk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:08 INFO - Running setup.py (path:/tmp/pip-7IJTRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:08 INFO - Running setup.py (path:/tmp/pip-iIxgg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:08 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)) 15:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:08 INFO - Running setup.py (path:/tmp/pip-JpLGMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:09 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)) 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:09 INFO - Running setup.py (path:/tmp/pip-06pZsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:09 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)) 15:03:09 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)) 15:03:09 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)) 15:03:09 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)) 15:03:09 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)) 15:03:09 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)) 15:03:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:10 INFO - Downloading blessings-1.6.tar.gz 15:03:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:03:11 INFO - Installing collected packages: blessings 15:03:11 INFO - Running setup.py install for blessings 15:03:11 INFO - Successfully installed blessings 15:03:11 INFO - Cleaning up... 15:03:11 INFO - Return code: 0 15:03:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:11 INFO - Reading from file tmpfile_stdout 15:03:11 INFO - Current package versions: 15:03:11 INFO - argparse == 1.2.1 15:03:11 INFO - blessings == 1.6 15:03:11 INFO - blobuploader == 1.2.4 15:03:11 INFO - docopt == 0.6.1 15:03:11 INFO - manifestparser == 1.1 15:03:11 INFO - mozInstall == 1.12 15:03:11 INFO - mozcrash == 0.17 15:03:11 INFO - mozdebug == 0.1 15:03:11 INFO - mozdevice == 0.48 15:03:11 INFO - mozfile == 1.2 15:03:11 INFO - mozhttpd == 0.7 15:03:11 INFO - mozinfo == 0.9 15:03:11 INFO - mozleak == 0.1 15:03:11 INFO - mozlog == 3.1 15:03:11 INFO - moznetwork == 0.27 15:03:11 INFO - mozprocess == 0.22 15:03:11 INFO - mozprofile == 0.28 15:03:11 INFO - mozrunner == 6.11 15:03:11 INFO - mozscreenshot == 0.1 15:03:11 INFO - mozsystemmonitor == 0.0 15:03:11 INFO - moztest == 0.7 15:03:11 INFO - mozversion == 1.4 15:03:11 INFO - psutil == 3.1.1 15:03:11 INFO - requests == 1.2.3 15:03:11 INFO - wsgiref == 0.1.2 15:03:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:11 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')]} 15:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:11 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')]} 15:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:11 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 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:03:11 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 15:03:11 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 15:03:11 INFO - Using env: {'DISPLAY': ':0', 15:03:11 INFO - 'HOME': '/home/cltbld', 15:03:11 INFO - 'LANG': 'en_US.UTF-8', 15:03:11 INFO - 'LANGUAGE': 'en_US:en', 15:03:11 INFO - 'LOGNAME': 'cltbld', 15:03:11 INFO - 'MAIL': '/var/mail/cltbld', 15:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:11 INFO - 'MOZ_NO_REMOTE': '1', 15:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:11 INFO - 'NO_EM_RESTART': '1', 15:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:11 INFO - 'PWD': '/builds/slave/test', 15:03:11 INFO - 'SHELL': '/bin/bash', 15:03:11 INFO - 'SHLVL': '1', 15:03:11 INFO - 'TERM': 'linux', 15:03:11 INFO - 'TMOUT': '86400', 15:03:11 INFO - 'USER': 'cltbld', 15:03:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:11 INFO - '_': '/tools/buildbot/bin/python'} 15:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 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)) 15:03:11 INFO - Cleaning up... 15:03:11 INFO - Return code: 0 15:03:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:03:11 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')]} 15:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:11 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')]} 15:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:11 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 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:03:11 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 15:03:11 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 15:03:11 INFO - Using env: {'DISPLAY': ':0', 15:03:11 INFO - 'HOME': '/home/cltbld', 15:03:11 INFO - 'LANG': 'en_US.UTF-8', 15:03:11 INFO - 'LANGUAGE': 'en_US:en', 15:03:11 INFO - 'LOGNAME': 'cltbld', 15:03:11 INFO - 'MAIL': '/var/mail/cltbld', 15:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:11 INFO - 'MOZ_NO_REMOTE': '1', 15:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:11 INFO - 'NO_EM_RESTART': '1', 15:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:11 INFO - 'PWD': '/builds/slave/test', 15:03:11 INFO - 'SHELL': '/bin/bash', 15:03:11 INFO - 'SHLVL': '1', 15:03:11 INFO - 'TERM': 'linux', 15:03:11 INFO - 'TMOUT': '86400', 15:03:11 INFO - 'USER': 'cltbld', 15:03:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:11 INFO - '_': '/tools/buildbot/bin/python'} 15:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:11 INFO - Downloading/unpacking jsonschema 15:03:11 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 15:03:11 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 15:03:11 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 15:03:11 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 15:03:11 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 15:03:11 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 15:03:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:03:13 INFO - Downloading/unpacking functools32 (from jsonschema) 15:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:14 INFO - Downloading functools32-3.2.3-2.tar.gz 15:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:03:14 INFO - warning: no files found matching '*.txt' 15:03:14 INFO - no previously-included directories found matching 'build' 15:03:14 INFO - no previously-included directories found matching 'dist' 15:03:14 INFO - no previously-included directories found matching '.git*' 15:03:14 INFO - Installing collected packages: jsonschema, functools32 15:03:14 INFO - Running setup.py install for functools32 15:03:14 INFO - warning: no files found matching '*.txt' 15:03:14 INFO - no previously-included directories found matching 'build' 15:03:14 INFO - no previously-included directories found matching 'dist' 15:03:14 INFO - no previously-included directories found matching '.git*' 15:03:14 INFO - Successfully installed jsonschema functools32 15:03:14 INFO - Cleaning up... 15:03:14 INFO - Return code: 0 15:03:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02dd620f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a10770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', '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 15:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:03:14 INFO - Using env: {'DISPLAY': ':0', 15:03:14 INFO - 'HOME': '/home/cltbld', 15:03:14 INFO - 'LANG': 'en_US.UTF-8', 15:03:14 INFO - 'LANGUAGE': 'en_US:en', 15:03:14 INFO - 'LOGNAME': 'cltbld', 15:03:14 INFO - 'MAIL': '/var/mail/cltbld', 15:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:14 INFO - 'MOZ_NO_REMOTE': '1', 15:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:14 INFO - 'NO_EM_RESTART': '1', 15:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:14 INFO - 'PWD': '/builds/slave/test', 15:03:14 INFO - 'SHELL': '/bin/bash', 15:03:14 INFO - 'SHLVL': '1', 15:03:14 INFO - 'TERM': 'linux', 15:03:14 INFO - 'TMOUT': '86400', 15:03:14 INFO - 'USER': 'cltbld', 15:03:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:14 INFO - '_': '/tools/buildbot/bin/python'} 15:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:14 INFO - Downloading/unpacking flake8 15:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:03:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:03:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:03:17 INFO - no previously-included directories found matching 'docs/_build' 15:03:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:03:17 INFO - Running setup.py install for pep8 15:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:03:17 INFO - no previously-included directories found matching 'docs/_build' 15:03:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:03:17 INFO - Cleaning up... 15:03:17 INFO - Return code: 0 15:03:17 INFO - Running post-action listener: _resource_record_post_action 15:03:17 INFO - Running post-action listener: _start_resource_monitoring 15:03:17 INFO - Starting resource monitoring. 15:03:17 INFO - ##### 15:03:17 INFO - ##### Finished create-virtualenv step (success) 15:03:17 INFO - ##### 15:03:17 INFO - ##### 15:03:17 INFO - ##### Running install step. 15:03:17 INFO - ##### 15:03:17 INFO - Running pre-action listener: _resource_record_pre_action 15:03:17 INFO - Running main action method: install 15:03:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:17 INFO - Reading from file tmpfile_stdout 15:03:17 INFO - Detecting whether we're running mozinstall >=1.0... 15:03:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:03:17 INFO - Reading from file tmpfile_stdout 15:03:17 INFO - Output received: 15:03:17 INFO - Usage: mozinstall [options] installer 15:03:17 INFO - Options: 15:03:17 INFO - -h, --help show this help message and exit 15:03:17 INFO - -d DEST, --destination=DEST 15:03:17 INFO - Directory to install application into. [default: 15:03:17 INFO - "/builds/slave/test"] 15:03:17 INFO - --app=APP Application being installed. [default: firefox] 15:03:17 INFO - mkdir: /builds/slave/test/build/application 15:03:17 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'] 15:03:17 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 15:03:33 INFO - Reading from file tmpfile_stdout 15:03:33 INFO - Output received: 15:03:33 INFO - /builds/slave/test/build/application/firefox/firefox 15:03:33 INFO - Running post-action listener: _resource_record_post_action 15:03:33 INFO - ##### 15:03:33 INFO - ##### Finished install step (success) 15:03:33 INFO - ##### 15:03:33 INFO - ##### 15:03:33 INFO - ##### Running run-tests step. 15:03:33 INFO - ##### 15:03:33 INFO - Running pre-action listener: _resource_record_pre_action 15:03:33 INFO - Running main action method: run_tests 15:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:33 INFO - Python 2.7.3 15:03:33 INFO - Return code: 0 15:03:33 INFO - grabbing minidump binary from tooltool 15:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f9c0>, '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 0x2aa08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:03:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:03:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:33 INFO - Return code: 0 15:03:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:03:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:03:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:03:34 INFO - Return code: 0 15:03:34 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/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:03:34 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/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:03:34 INFO - Using env: {'DISPLAY': ':0', 15:03:34 INFO - 'HOME': '/home/cltbld', 15:03:34 INFO - 'LANG': 'en_US.UTF-8', 15:03:34 INFO - 'LANGUAGE': 'en_US:en', 15:03:34 INFO - 'LOGNAME': 'cltbld', 15:03:34 INFO - 'MAIL': '/var/mail/cltbld', 15:03:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:34 INFO - 'MOZ_NO_REMOTE': '1', 15:03:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:34 INFO - 'NO_EM_RESTART': '1', 15:03:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:34 INFO - 'PWD': '/builds/slave/test', 15:03:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:34 INFO - 'SHELL': '/bin/bash', 15:03:34 INFO - 'SHLVL': '1', 15:03:34 INFO - 'TERM': 'linux', 15:03:34 INFO - 'TMOUT': '86400', 15:03:34 INFO - 'USER': 'cltbld', 15:03:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923', 15:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:34 INFO - '_': '/tools/buildbot/bin/python'} 15:03:34 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/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:03:34 INFO - mozversion application_buildid: 20160509142802 15:03:34 INFO - mozversion application_changeset: a3033ed384eb846bf37d9a4bf59a3728f15e9f74 15:03:34 INFO - mozversion application_display_name: Nightly 15:03:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:34 INFO - mozversion application_name: Firefox 15:03:34 INFO - mozversion application_remotingname: firefox 15:03:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:03:34 INFO - mozversion application_vendor: Mozilla 15:03:34 INFO - mozversion application_version: 49.0a1 15:03:34 INFO - mozversion platform_buildid: 20160509142802 15:03:34 INFO - mozversion platform_changeset: a3033ed384eb846bf37d9a4bf59a3728f15e9f74 15:03:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:03:34 INFO - mozversion platform_version: 49.0a1 15:03:34 INFO - using testdate: 1462831414 15:03:34 INFO - actual date: 1462831414 15:03:34 INFO - starting webserver on 'localhost:45691' 15:03:34 INFO - SUITE-START | Running 2 tests 15:03:34 INFO - TEST-START | dromaeo_css 15:03:34 INFO - operating with platform_type : linux_ 15:03:34 INFO - Initialising browser for dromaeo_css test... 15:03:34 INFO - TEST-INFO | started process 13948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXQVdr5/profile http://localhost:45691/getInfo.html) 15:03:39 INFO - PROCESS | 13948 | __metrics Screen width/height:1600/1200 15:03:39 INFO - PROCESS | 13948 | colorDepth:24 15:03:39 INFO - PROCESS | 13948 | Browser inner width/height: 1024/697 15:03:39 INFO - PROCESS | 13948 | __metrics 15:03:40 ERROR - PROCESS | 13948 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:03:41 INFO - TEST-INFO | 13948: exit 0 15:03:41 INFO - Browser initialized. 15:03:41 INFO - Running cycle 1/1 for dromaeo_css test... 15:03:41 INFO - TEST-INFO | started process 14027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXQVdr5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:53 INFO - PROCESS | 14027 | RSS: Main: 153812992 15:03:53 INFO - PROCESS | 14027 | 15:04:44 INFO - PROCESS | 14027 | 1462831484704 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] 15:06:56 INFO - PROCESS | 14027 | Cycle 1(1): loaded http://localhost:45691/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45691/tests/dromaeo/cssquery-ext.html) 15:06:57 INFO - PROCESS | 14027 | RSS: Main: 258691072 15:06:57 INFO - PROCESS | 14027 | 15:10:00 INFO - PROCESS | 14027 | Cycle 1(1): loaded http://localhost:45691/tests/dromaeo/cssquery-ext.html (next: http://localhost:45691/tests/dromaeo/cssquery-jquery.html) 15:10:00 INFO - PROCESS | 14027 | RSS: Main: 235393024 15:10:00 INFO - PROCESS | 14027 | 15:13:03 INFO - PROCESS | 14027 | Cycle 1(1): loaded http://localhost:45691/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45691/tests/dromaeo/cssquery-mootools.html) 15:13:03 INFO - PROCESS | 14027 | RSS: Main: 234631168 15:13:03 INFO - PROCESS | 14027 | 15:16:05 INFO - PROCESS | 14027 | Cycle 1(1): loaded http://localhost:45691/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45691/tests/dromaeo/cssquery-prototype.html) 15:16:06 INFO - PROCESS | 14027 | RSS: Main: 233881600 15:16:06 INFO - PROCESS | 14027 | 15:19:09 INFO - PROCESS | 14027 | Cycle 1(1): loaded http://localhost:45691/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45691/tests/dromaeo/cssquery-yui.html) 15:19:09 INFO - PROCESS | 14027 | RSS: Main: 205021184 15:19:09 INFO - PROCESS | 14027 | 15:22:12 INFO - PROCESS | 14027 | Cycle 1(1): loaded http://localhost:45691/tests/dromaeo/cssquery-yui.html (next: http://localhost:45691/tests/dromaeo/cssquery-dojo.html) 15:22:13 INFO - PROCESS | 14027 | RSS: Main: 285675520 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - PROCESS | 14027 | __start_tp_report 15:22:13 INFO - PROCESS | 14027 | _x_x_mozilla_page_load 15:22:13 INFO - PROCESS | 14027 | _x_x_mozilla_page_load_details 15:22:13 INFO - PROCESS | 14027 | |i|pagename|runs| 15:22:13 INFO - PROCESS | 14027 | |0;dojo.html;2653.1907768130714;2657.508360953224;2687.046098634986;2705.9458810823785;2713.782897368211;4553.772311384434;4614.007988282518;4667.556582124697;4747.7388743619085;4802.783874725637;4648.976755116229;4714.5285471452835;4727.243641017438;4741.786619602126;4822.6624136310475;4297.441332626762;4307.267764480046;4310.331898555713;4427.313766366218;4430.734155950653;4374.956250437487;4429;4465.040016396474;4507.323901414781;4511.187986162489;4165.437665915093;4383.978080109611;4407.757573333465;4430.977845110786;4441.689081764262;4222.134462435224;4244.299690551055;4270.295401258789;4296.828126874952;4301.354796780477;4275.0594869128745;4325.675574331937;4335.631471324941;4343.326784348431;4390.078083602447;4434.091011342699;4622.6070783983405;4641.373414589055;4649.465311489154;4652.720836749806;4954.083494553519;4991.875203119915;5001;5005.699658020494;5065.1642478990925;5009.448960614366;5043.495650434964;5065.366829146356;5073.441921388644;5080.949190508085;4602.05657840142;4731.763411829464;4763.571278584944;4766.666333356701;4775;5187.922181167285;5272.947270527322;5288.312519372457;5293.814716484904;5295.549878260314;5031.195008798648;5031.320771695848;5036.345275114211;5085.084684756705;5090.185570308733;4893.73084480357;5036;5113.693178409308;5118.436971933084;5120.206368012964;5009.24861270805;5033.119204139261;5054.469280725544;5067.290579318898;5101.668391554611;5040.117979353672;5051.26756620288;5051.87370315745;5054.545090941833;5110.105731496973;4192.245395828719;4209.074003719238;4224.429701990253;4355.586219309161;4401.845935392246;3745.9250814983548;3778.3954567269107;3788.412796016622;3790.56408513019;3825.407061905409;4306.720063195882;4316.115196384733;4316.5467625899455;4361.6510679145595;4362.389265502832;4842.903141937141;5060.949390506122;5065.138926382524;5069.569086627678;5116.513931176532;4280.250956082673;4302.397664326997;4329.069250111241;4342.1532801103485;4384.188925048876;4620.930686039712;4621.19129152397;4622.075584883037;4622.144903192853;4669.813207471663;4635.212013957703;4787.3537072495465;4789.066132104206;4801.303810947324;4830.830920917751;4980.626453015966;5018.172001619692;5020.347354843993;5030.8239211627415;5057.418396884405;4717.551832575899;4719.10337035962;4730.136461551412;4767.6662633615315;4788.401449818773;4728.71627702339;4948.430930443045;4975.5522003019905;4986.376702912136;5029.7736601852275;5047;5062.417821950523;5083.313752643346;5131.435542090292;5143.6399452037995;4941.802327906844;4944.505549445027;4944.851654450372;4948.975255123702;4991.575716064175;4702.858914232578;4795.256735206049;4925.482824303396;4926.605871530197;4961.479044700254;4803.087413391444;4863.805447782049;4880.487548807324;4882.584980276574;4888.144574699484;4935.851924442272;4937.456879743298;4938.851834444972;4978.925316120189;4986.9251961221335;4679.578837904605;4832.1543729846435;4836.056968891173;4838.371011768448;4884.535969082932 15:22:13 INFO - PROCESS | 14027 | |1;ext.html;579.0156733552958;604.3744724210441;605.7334772700015;606.8937935861225;618.1654766065811;27837;43523.78238108809;43800.12399752011;43911;44070.559294407045;43420.782896085555;43942.34086488705;44026.55973440265;44071;44102.33846492305;7433;7965.243301886326;8129.918700812976;10024.649137280197;10399.428031458267;10120.797584048314;10219.28465007446;10239.641612543563;10240.846387304158;10249.385036897773;10205.132563732092;10244.487775611227;10256.846147307759;10262.33294835837;10264.178865690765;7528.360089392381;10031.545425913202;10210.693679189637;10256.74358141045;10588.470576471145;9951.601935922554;10009.749756256078;10014.298999070068;10016.298859079867;10027.247956403298;40136.799316003526;40417;40426.595734042574;40444.797776011226;40481.79759101215;3204.83975801209;3246.480563109891;3288.6053673559086;3326.101952472819;3572.4819901114192;31293;31582.842085789653;31789.20526986844;31880.521792173135;32909;3229.9677003230136;3237.1421573282864;3242.7243684286864;3300.2409445827593;3304.8843290484956;239898;240819;241699.79150104313;241737;242523;34524;56331.338462999774;56789.148162777594;56799.43200568024;56852.43147568554;34487.4826877597;36412.089697757765;36450;36573.08567285786;36652.450213246826;11463.828042579367;13056.151350162208;13196;13212.669683257804;13214.141080829715;10143.340682855738;10309.793804124025;10330.070293673605;10448.843267350996;10449.111825494918;8529.914700853036;8540.316774658013;8540.615672294762;8611.440256383315;8627.91372086271;3216.565763621928;3301.3397320535987;3302.78531895426;3325.1022223999385;3366.848491817874;898.3172788680649;953.4946478366477;999.8700168977987;1016.5577973581516;1045.7333379988054;29202.707972919998;29389.559156612668;29455.263618409284;29885.551716724265;29931.551026734618;974.8878878928872;1037.7301901505512;1042.9805712462378;1067.604986155112;1098.95050227033;15386.230688465532;15627.296771645304;15772.369105235663;15868.759992452759;16015.119168445848;354365;359914;359987;360144;360158;51645.22532162021;51665.741671292155;52047.47952520502;52240;52269;1128.3399211461224;1204.9096317776377;1229.624964385871;1257.654145110102;1259.2318685601776;27753.722462775113;29797.85101074481;29960.80548723137;30385.392292153592;30686.846565767028;43021;43087.56912430836;43519.78240108779;43580.782096089315;43596.56403435925;279733;280329;282640;283221;283249;23458.296251111813;25963.22110336693;26519.602205967312;26736.331591710365;26874.865625671748;43374.78312608543;43733.78133109314;44184.558154418046;44774.10451790881;45435.09129817451;36161.63838361583;37205.6279437213;37212;37815.62184378121;37981.240375192894;37085.814570926974;37111;37113.56695507035;37386.8130659345;37854;36480.27039459249;36656.45015324719;38802.80598596989;39288;39583.2083358337;32867.178320542174;34458.483122752674;34727.305453891284;35376.11559711028;35654.108647284025;26162.86918565395;26654.46691066129;26822.463550729266;27115.505537869172;27375.315617109733 15:22:13 INFO - PROCESS | 14027 | |2;jquery.html;373.9644733750293;376.6139706800529;379.40054713552587;390.7635880292421;391.7668986952764;16067.598310042255;16075.75886361704;17416.777099130173;17591.208395622194;17604.911975440104;15885.920570397131;16376;17298.048607326593;17302.653946921055;17343.39298124566;4745.501722319159;4944.678595891256;4971.37857767779;4979.402471703401;4982.501749825006;3563.893083207495;5387.138057910735;5648.943510564883;5677.261955945722;5784.074548072309;5672.716364181774;5749.971250143764;5756.165356023374;5776.826695199151;5789.9710501447435;5587.798623296011;5721.7711291548285;5743.856403589923;5747.655140691572;5749.885002299951;3389.6271410144864;3569.089882080053;3572.285542891432;3577.409727394977;5119.104156772587;12091.516339346415;12502.437390317458;12597.370131493388;12632.17890837102;12680.365981700877;1938.6995015772436;2072.347210628662;2080.251109600543;2087.09211493001;2223.132978138527;9036.728898133066;9209.171174594252;9587.185089267421;9750.05842079885;9862.260330475243;1685.578605348663;1804.4676820338032;1817.7182536706832;1818.8999605021718;1857.9163937622839;72750.63624681842;72792;73051.26948730498;73197.26802731905;73231;9705.805883882424;9782.608695652236;9888.950555247178;10174;10349.275550711529;13120.803187952188;13121;13202.085697573799;13213.735725285633;13221.933890330487;6941.34057264559;6992.3357281058215;6992.545484543489;7038.788836334918;7143.464240182007;6700.128983232149;6724.394804467622;6731.562448440835;6806.829829254309;6888.621125838127;4159.521655009713;4378.671599630041;4478.096808856223;4559.863204103882;4608.654350923694;1708.1544635405553;3140.371925614886;3141.8114913105287;3210.8234047127166;3252.121927079675;790.3835008693228;804.3002587748696;838.279079991207;873.4759144513241;995.4475266227169;15529.378824847106;16914.577135571464;16954;17291;17430.65138697219;901.9143181397887;909.0182602788972;909.1317791509093;916.170865366844;942.9622815087457;9068.81862362749;9575.760605984906;9662.806743865223;9707.271954603291;9793.412395256308;416491;424756;433018;433155;441281;79820.60089699514;80041;80907.59546202232;81069;81402;949.2595775295142;956.6986399284203;959.947202903833;962.870012548297;970.0978090375877;14849.92575037118;14855.628609284855;14931.85068149348;15077.246137693292;15179.696406072038;32218;32595.348093037534;32896.67103328936;33028.66971330256;34636.30727385489;45891.77054114708;47092.29361559648;47356.2896556545;47816;52645.47354526406;7564.4704870658525;7661.770146895602;7773.41699372538;7800.375969922506;7886.645100970355;8523.616437260214;10455.320404173704;11289.37908415045;11448.542058317908;11648.126390520576;7576.545407275581;9363.906360936577;9546.570404331684;9940.652077177265;9949.204063675033;9696.9030309696;9727.367721098106;9965;10001.599936002478;10103.393796372242;10051.949740251544;10085;10256.641017564349;10409;10621.946890265499;7614.847703046019;7685;7708.0402661799;7781.299683028555;8008.238187598719;7654.464187507044;9713.9028609713;10120.746981325232;10221.9488902555;10359.482025898826 15:22:13 INFO - PROCESS | 14027 | |3;mootools.html;1257.9685507862296;1469.2580246975278;1496.0873866941165;1657.9834201657986;1835.4126679462577;6916.342947419993;7243.7826865194065;7255.56466612003;7388.926110738891;7398.223186565414;7209.243029481908;7362.300581444768;7367.594782286972;7383.889241661379;7386.630668466582;1751.6409136127127;2045.4068320187127;2073.7407824022034;2100.653392190287;2117.4071260047212;2058.7735349111585;2065.401033700225;2069.6067747128;2071.9482012949647;2072.1711315473854;2036.0125339210472;2055.342290467051;2063.319104695447;2064.7006184103298;2066.3387715930908;1980.3167907072036;2009.2164056018164;2040.6428874946973;2050.6001329740707;2051.815336619704;2008.4978755311172;2013.2349707111205;2031.0555591649807;2034.1253261097722;2037.7045328427444;7388.704451821921;7446.776596702108;7449.255074492562;7458.328750412435;7464.776056718307;4269.509006464265;4371.475422949235;4377.080813029268;4381.342798580238;4416.050549131952;2399.652050452692;2706.648135742341;2980.3741214345014;2982.388610334876;2984.2091845660916;824.5382585751998;965.9565319560637;970.0541971577726;1000.5947591225565;1019.5463018956567;9753.268504862164;9766.706998790047;9798.853017204749;9819.656312029045;9865.90134098657;3945.2504024235304;4062.756234625873;4118.588141185857;4124.752514849119;4146.896327591834;8258.174182581693;8315.334773218128;8315.875261871077;8321.043080045873;8375.748727538183;3766.133789228493;4582.175208462509;4588.334691469719;4589.173948689201;4592.862214133581;3907.081835768592;4000.6599439047427;4021.557628660845;4023.4769479968004;4028.778417187083;3487.598926123528;3558.1282585766653;3584.6953008994005;3593.94609080864;3695.279420512974;1109.522905150793;1192.3918801411169;1206.481213078367;1209.2623499665197;1210.03197442046;866.7443104284251;881.8412685716504;885.4377470306401;885.4952676974192;893.5576889439639;5053.216751403538;5280.419153893069;5335.733213339317;5360.517553420133;5445.401005889349;878.4641368765048;884.6284560484484;899.1682693508609;910.5811326789751;925.9444433334022;3550.2721942001826;3598.1184609770776;3620.606066664353;3631;3681.3925702258825;8786.86819697705;9052.27581793455;9113.498757568397;9194.586243619053;9215.44707317563;8985.955070224607;9020;9063.54682265884;9093.863592046124;9106.772330691785;6603.504737144734;6897.172339319314;6915.204751453647;6923.653817309215;6924.688389022506;5144.176931690911;5205.531502164823;5267.544757160982;5321.521063104339;5462.9180562292395;8345.41582089248;8347.666093356198;8377;8425.325973922194;8587.699430519902;8478.40651154438;8543.572821358783;8544.829103418022;8590.484570925764;8630.568471576522;5579.832605021856;6017.623869521405;6100;6503.804885853432;6633.038209459698;6734.259231484435;6787.93212067873;6802.727890884309;7306.123265208209;7398.038255026812;6620.834479137868;6662.533622646368;6666.799996000128;6763.492738044568;6782.96608516974;6580.21037475506;6599.505037122139;6604.306547812603;6691.397774200345;6768.661566921536;5968.104784282219;6001.039833626599;6038.064100064497;6038.969805150946;6039.6678182698615;4478.507364190002;4500.752458614807;4592.793324300348;4617.422822147231;4694.788734507024;4478.753668548261;4567.657425693153;4581.060882519142;4623.16782979067;4655.534446555453 15:22:13 INFO - PROCESS | 14027 | |4;prototype.html;309.9938001239975;313.6581126572036;317.2402096977738;320.3864599292354;321.1649710752046;4851.660383773137;4870.099031679138;4876.36607241059;4878.902421951559;4892.486288939664;4761.690490118149;4795.616350691945;4798.784054717537;4815.951840481594;4820.39745031871;3613.8012409317475;3750.3061933542244;3790.7915064671433;3841.19334939663;3870.903227419323;3823.5220597425323;3856.7878766667823;3869.284182426246;3876.8757060452435;3907.4920260366252;3604.5133906922624;3830.253100645375;3832.2718683450057;3840.788756618385;3844.5578758442857;3623.547056617923;3742.719296052807;3748.7188460865273;3751;3858.247641709868;3392.1858753898887;3419.675130862589;3425.520427140202;3429.828508574586;3439.2605589798063;4595.195840727893;4611;4629;4635.443746750378;4643.837465688718;4291.957080429218;4333.523312435629;4363.847265345729;4375.868723938287;4413.823447062114;4965.503449655005;5014.373203349582;5030.974845125787;5047.4447810740785;5061.063703214917;3755.8122093895468;3773.7169712271416;3779.829907654162;3781.470594116826;3789.5263092113487;5192.494176688756;5299.8410047698635;5335.4131045585345;5374.8981458801245;5379.462053794589;3846.519185101806;3848.3073046851837;3853.479780229633;3860.4751123306137;3864.6908247340143;3892.4939757831303;3910.569837317893;3915.5888631693833;3927.19492504036;3932.2528719543766;4384.202476984421;4384.9123017540105;4413.933790993074;4420.535843736426;4426.44669416323;4832.299316599074;5096.9490305097215;5110.310108135354;5123.718195499283;5139.97200559882;1247.4635906560266;1266.2529107826426;1266.6959929616826;1268.289757735671;1270.2153474368527;839.1105428246078;871.6339137562239;878.8637761147032;892.7456923023162;898.4564338575199;4291.270484017725;4387.144506821203;4417.801198946056;4418.624416924597;4434.17967675981;5079.161938280216;5228.346456692913;5242.659227150223;5259.685078730317;5278.841634750964;4501.48232953208;4504.144212599595;4509.1658043262105;4509.436320459942;4511.255642818964;2605.025520219859;2701.446203528272;2711.9322016949736;2713.6200931869157;2740.287525243451;4787.640926930424;4818.71087734737;4837.677914601011;4848.927266091011;4879;5051;5147.948520514822;5181.196914478187;5186.273921650972;5206.464093092547;4857.295692124693;4861.6353773467135;4874.731889746027;4874.8537543873035;4882.36529251195;5042.890564075898;5081.8475445736685;5092.726818295426;5109;5122.564582010571;4799.784009719501;5012.273220382951;5024.145895197752;5085.338905942203;5091.574359179288;4806.327114204084;4834.782434790513;4838.467768545387;4839.685420447659;4850.53919877611;3598.028532296213;3603.6756691897854;3622.3298689742483;3624.1483251435366;3635.818209089588;5084.7966081356335;5090.694558326512;5109.448932991535;5114.846554603368;5157.277981082727;4656.278276867091;4944.195368690474;4949.282354058713;4954.479779623088;4980.203167493184;4936.136176169228;4951.529604687549;4953.804795906692;4967.6403708238295;4977.9751101244265;4854.247591623304;4862.544415070367;4895.46149923501;4901.411830580353;4901.90196196067;4643.83904023994;4897.853064407931;4975.527324904128;4996.150654388835;5032.798688052437;4944.975275123746;4994.400671919393;5002.424236365533;5022.598192144546;5022.974885125697 15:22:13 INFO - PROCESS | 14027 | |5;yui.html;765.8927750114985;801.310872649521;811.1619051396727;813.9715109971153;814.3932770086286;11072.833907491384;11334.319940803547;11561.421928903563;11568.132390070736;11582.073434125261;11349.943250283737;11352.829707554394;12275.877241227585;12579.119461637689;12591;662.5461558832216;844.7507985144366;859.0764927702729;867.9566021698921;872.8821609082788;859.8882145321099;870.4342177584557;870.9303255739526;871.4901782457271;876.3471213945619;914.7347269291897;917.7246825952221;917.7751450894507;918.0910898210757;918.485648037098;694.8262934266434;883.7746374674481;901.2384535067857;901.7384958362068;908.4503875155535;669.1568623534333;669.4343279928453;670.0251134599147;670.3464122480542;670.4167374384317;11439.313641181472;11458.770824583546;11465.369404682739;11465.426728663617;11471.369074700888;12114.394280285951;12334.444949977273;12472.50109995599;12564.434600443003;12813.679658008532;10912.836307455394;11196;11207.719807004809;11294.096472282197;11636.94181529087;4079.73481723687;4144.295469770116;4194.2450358935375;4238.957610423918;4284.271673815459;42779.144417111485;43967.340489892355;44416.777916110535;44440.3333949991;44453;8839.69061082859;8843.867341989875;9005.684801032063;9112.450883349846;9120.407173533698;16299.59251018734;16462.917685411496;16483.505494835175;16500.587485312724;16510.66978660444;6509.153810004764;6542.149520562297;6691.866162676719;6700.095487109178;6705.564138330993;3334.6498617645284;3511.5083888255663;3576.3562558739677;3665.9450108248398;3669.7614655047337;2686.1672881406826;2770.667519897625;2776.625155604008;2777.1946135620847;2778.374865655252;500.9524095210949;507.50771751401084;515.9277701121846;526.9446708095671;528.7541293298634;480.2148487223345;481.7470827815355;509.53254626674936;571.3115695586891;619.7706848466006;7166.605836679033;7492.550446973199;7742.496737712031;7796.688132474751;8008.359331253486;572.6163470474792;587.8412828536357;594.7591225553658;612.5956868466791;614.97232624532;3620.2759448110482;3636.509071275344;3742.6631603155847;3762.4168253920684;3765.736398452082;42032.36951445731;43459.34810977838;43629.345559816626;43854.34218486725;44928.77535612301;45482;45602.31596526055;46024.76987615041;46079.308810367875;46702;42010;42228.57771422246;42584;42909.785451072545;43504.12991740147;7631.236876312324;7655.770326890202;7720.112187098555;7856.25365590268;8115.959420202861;27371.72628273692;28775.424491509635;29168.27079323034;29184.27039323949;29806;33879.49180762241;34610.48084278788;36327;37176;37203.813980931;10254.230932680228;10390.584376625153;10575;10582.470876455993;10607.098396636373;11132.499037543492;11151.386673733023;11298.209125361145;11858.347790871585;11899.940500297444;10665.733356666145;10711.357318560911;10753.354798712102;11211.383373914514;11212;11094.889051109385;11110.388928609003;11686.415679216176;11686.94156529212;11723.062155027748;10676.519556620126;10814.89185108139;11169.050630696482;11397.544098235978;11432;8130.5915874629645;8212.548309843016;8458.957705211435;8473.322134229124;8624.482531048157;8182.218045864197;8330.791730206793;8576.914230857612;8724.91275087241;8741.475511469333 15:22:13 INFO - PROCESS | 14027 | __end_tp_report 15:22:13 INFO - PROCESS | 14027 | __start_cc_report 15:22:13 INFO - PROCESS | 14027 | _x_x_mozilla_cycle_collect,1018 15:22:13 INFO - PROCESS | 14027 | __end_cc_report 15:22:13 INFO - PROCESS | 14027 | __startTimestamp1462832533141__endTimestamp 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - PROCESS | 14027 | ------- Summary: start ------- 15:22:13 INFO - PROCESS | 14027 | Number of tests: 6 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - PROCESS | 14027 | [#0] dojo.html Cycles:165 Average:4671.14 Median:4788.40 stddev:485.76 (10.1%) stddev-sans-first:460.73 15:22:13 INFO - PROCESS | 14027 | Values: 2653.2 2657.5 2687.0 2705.9 2713.8 4553.8 4614.0 4667.6 4747.7 4802.8 4649.0 4714.5 4727.2 4741.8 4822.7 4297.4 4307.3 4310.3 4427.3 4430.7 4375.0 4429.0 4465.0 4507.3 4511.2 4165.4 4384.0 4407.8 4431.0 4441.7 4222.1 4244.3 4270.3 4296.8 4301.4 4275.1 4325.7 4335.6 4343.3 4390.1 4434.1 4622.6 4641.4 4649.5 4652.7 4954.1 4991.9 5001.0 5005.7 5065.2 5009.4 5043.5 5065.4 5073.4 5080.9 4602.1 4731.8 4763.6 4766.7 4775.0 5187.9 5272.9 5288.3 5293.8 5295.5 5031.2 5031.3 5036.3 5085.1 5090.2 4893.7 5036.0 5113.7 5118.4 5120.2 5009.2 5033.1 5054.5 5067.3 5101.7 5040.1 5051.3 5051.9 5054.5 5110.1 4192.2 4209.1 4224.4 4355.6 4401.8 3745.9 3778.4 3788.4 3790.6 3825.4 4306.7 4316.1 4316.5 4361.7 4362.4 4842.9 5060.9 5065.1 5069.6 5116.5 4280.3 4302.4 4329.1 4342.2 4384.2 4620.9 4621.2 4622.1 4622.1 4669.8 4635.2 4787.4 4789.1 4801.3 4830.8 4980.6 5018.2 5020.3 5030.8 5057.4 4717.6 4719.1 4730.1 4767.7 4788.4 4728.7 4948.4 4975.6 4986.4 5029.8 5047.0 5062.4 5083.3 5131.4 5143.6 4941.8 4944.5 4944.9 4949.0 4991.6 4702.9 4795.3 4925.5 4926.6 4961.5 4803.1 4863.8 4880.5 4882.6 4888.1 4935.9 4937.5 4938.9 4978.9 4986.9 4679.6 4832.2 4836.1 4838.4 4884.5 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - PROCESS | 14027 | [#1] ext.html Cycles:180 Average:45457.86 Median:3300.79 stddev:78167.06 (2368.1%) stddev-sans-first:78313.71 15:22:13 INFO - PROCESS | 14027 | Values: 579.0 604.4 605.7 606.9 618.2 27837.0 43523.8 43800.1 43911.0 44070.6 43420.8 43942.3 44026.6 44071.0 44102.3 7433.0 7965.2 8129.9 10024.6 10399.4 10120.8 10219.3 10239.6 10240.8 10249.4 10205.1 10244.5 10256.8 10262.3 10264.2 7528.4 10031.5 10210.7 10256.7 10588.5 9951.6 10009.7 10014.3 10016.3 10027.2 40136.8 40417.0 40426.6 40444.8 40481.8 3204.8 3246.5 3288.6 3326.1 3572.5 31293.0 31582.8 31789.2 31880.5 32909.0 3230.0 3237.1 3242.7 3300.2 3304.9 239898.0 240819.0 241699.8 241737.0 242523.0 34524.0 56331.3 56789.1 56799.4 56852.4 34487.5 36412.1 36450.0 36573.1 36652.5 11463.8 13056.2 13196.0 13212.7 13214.1 10143.3 10309.8 10330.1 10448.8 10449.1 8529.9 8540.3 8540.6 8611.4 8627.9 3216.6 3301.3 3302.8 3325.1 3366.8 898.3 953.5 999.9 1016.6 1045.7 29202.7 29389.6 29455.3 29885.6 29931.6 974.9 1037.7 1043.0 1067.6 1099.0 15386.2 15627.3 15772.4 15868.8 16015.1 354365.0 359914.0 359987.0 360144.0 360158.0 51645.2 51665.7 52047.5 52240.0 52269.0 1128.3 1204.9 1229.6 1257.7 1259.2 27753.7 29797.9 29960.8 30385.4 30686.8 43021.0 43087.6 43519.8 43580.8 43596.6 279733.0 280329.0 282640.0 283221.0 283249.0 23458.3 25963.2 26519.6 26736.3 26874.9 43374.8 43733.8 44184.6 44774.1 45435.1 36161.6 37205.6 37212.0 37815.6 37981.2 37085.8 37111.0 37113.6 37386.8 37854.0 36480.3 36656.5 38802.8 39288.0 39583.2 32867.2 34458.5 34727.3 35376.1 35654.1 26162.9 26654.5 26822.5 27115.5 27375.3 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - PROCESS | 14027 | [#2] jquery.html Cycles:180 Average:25103.64 Median:26380.34 stddev:70886.59 (268.7%) stddev-sans-first:71061.12 15:22:13 INFO - PROCESS | 14027 | Values: 374.0 376.6 379.4 390.8 391.8 16067.6 16075.8 17416.8 17591.2 17604.9 15885.9 16376.0 17298.0 17302.7 17343.4 4745.5 4944.7 4971.4 4979.4 4982.5 3563.9 5387.1 5648.9 5677.3 5784.1 5672.7 5750.0 5756.2 5776.8 5790.0 5587.8 5721.8 5743.9 5747.7 5749.9 3389.6 3569.1 3572.3 3577.4 5119.1 12091.5 12502.4 12597.4 12632.2 12680.4 1938.7 2072.3 2080.3 2087.1 2223.1 9036.7 9209.2 9587.2 9750.1 9862.3 1685.6 1804.5 1817.7 1818.9 1857.9 72750.6 72792.0 73051.3 73197.3 73231.0 9705.8 9782.6 9889.0 10174.0 10349.3 13120.8 13121.0 13202.1 13213.7 13221.9 6941.3 6992.3 6992.5 7038.8 7143.5 6700.1 6724.4 6731.6 6806.8 6888.6 4159.5 4378.7 4478.1 4559.9 4608.7 1708.2 3140.4 3141.8 3210.8 3252.1 790.4 804.3 838.3 873.5 995.4 15529.4 16914.6 16954.0 17291.0 17430.7 901.9 909.0 909.1 916.2 943.0 9068.8 9575.8 9662.8 9707.3 9793.4 416491.0 424756.0 433018.0 433155.0 441281.0 79820.6 80041.0 80907.6 81069.0 81402.0 949.3 956.7 959.9 962.9 970.1 14849.9 14855.6 14931.9 15077.2 15179.7 32218.0 32595.3 32896.7 33028.7 34636.3 45891.8 47092.3 47356.3 47816.0 52645.5 7564.5 7661.8 7773.4 7800.4 7886.6 8523.6 10455.3 11289.4 11448.5 11648.1 7576.5 9363.9 9546.6 9940.7 9949.2 9696.9 9727.4 9965.0 10001.6 10103.4 10051.9 10085.0 10256.6 10409.0 10621.9 7614.8 7685.0 7708.0 7781.3 8008.2 7654.5 9713.9 10120.7 10221.9 10359.5 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - PROCESS | 14027 | [#3] mootools.html Cycles:180 Average:4913.95 Median:5454.16 stddev:2673.85 (49.0%) stddev-sans-first:2667.23 15:22:13 INFO - PROCESS | 14027 | Values: 1258.0 1469.3 1496.1 1658.0 1835.4 6916.3 7243.8 7255.6 7388.9 7398.2 7209.2 7362.3 7367.6 7383.9 7386.6 1751.6 2045.4 2073.7 2100.7 2117.4 2058.8 2065.4 2069.6 2071.9 2072.2 2036.0 2055.3 2063.3 2064.7 2066.3 1980.3 2009.2 2040.6 2050.6 2051.8 2008.5 2013.2 2031.1 2034.1 2037.7 7388.7 7446.8 7449.3 7458.3 7464.8 4269.5 4371.5 4377.1 4381.3 4416.1 2399.7 2706.6 2980.4 2982.4 2984.2 824.5 966.0 970.1 1000.6 1019.5 9753.3 9766.7 9798.9 9819.7 9865.9 3945.3 4062.8 4118.6 4124.8 4146.9 8258.2 8315.3 8315.9 8321.0 8375.7 3766.1 4582.2 4588.3 4589.2 4592.9 3907.1 4000.7 4021.6 4023.5 4028.8 3487.6 3558.1 3584.7 3593.9 3695.3 1109.5 1192.4 1206.5 1209.3 1210.0 866.7 881.8 885.4 885.5 893.6 5053.2 5280.4 5335.7 5360.5 5445.4 878.5 884.6 899.2 910.6 925.9 3550.3 3598.1 3620.6 3631.0 3681.4 8786.9 9052.3 9113.5 9194.6 9215.4 8986.0 9020.0 9063.5 9093.9 9106.8 6603.5 6897.2 6915.2 6923.7 6924.7 5144.2 5205.5 5267.5 5321.5 5462.9 8345.4 8347.7 8377.0 8425.3 8587.7 8478.4 8543.6 8544.8 8590.5 8630.6 5579.8 6017.6 6100.0 6503.8 6633.0 6734.3 6787.9 6802.7 7306.1 7398.0 6620.8 6662.5 6666.8 6763.5 6783.0 6580.2 6599.5 6604.3 6691.4 6768.7 5968.1 6001.0 6038.1 6039.0 6039.7 4478.5 4500.8 4592.8 4617.4 4694.8 4478.8 4567.7 4581.1 4623.2 4655.5 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - PROCESS | 14027 | [#4] prototype.html Cycles:180 Average:4195.13 Median:4799.28 stddev:1194.80 (24.9%) stddev-sans-first:1162.02 15:22:13 INFO - PROCESS | 14027 | Values: 310.0 313.7 317.2 320.4 321.2 4851.7 4870.1 4876.4 4878.9 4892.5 4761.7 4795.6 4798.8 4816.0 4820.4 3613.8 3750.3 3790.8 3841.2 3870.9 3823.5 3856.8 3869.3 3876.9 3907.5 3604.5 3830.3 3832.3 3840.8 3844.6 3623.5 3742.7 3748.7 3751.0 3858.2 3392.2 3419.7 3425.5 3429.8 3439.3 4595.2 4611.0 4629.0 4635.4 4643.8 4292.0 4333.5 4363.8 4375.9 4413.8 4965.5 5014.4 5031.0 5047.4 5061.1 3755.8 3773.7 3779.8 3781.5 3789.5 5192.5 5299.8 5335.4 5374.9 5379.5 3846.5 3848.3 3853.5 3860.5 3864.7 3892.5 3910.6 3915.6 3927.2 3932.3 4384.2 4384.9 4413.9 4420.5 4426.4 4832.3 5096.9 5110.3 5123.7 5140.0 1247.5 1266.3 1266.7 1268.3 1270.2 839.1 871.6 878.9 892.7 898.5 4291.3 4387.1 4417.8 4418.6 4434.2 5079.2 5228.3 5242.7 5259.7 5278.8 4501.5 4504.1 4509.2 4509.4 4511.3 2605.0 2701.4 2711.9 2713.6 2740.3 4787.6 4818.7 4837.7 4848.9 4879.0 5051.0 5147.9 5181.2 5186.3 5206.5 4857.3 4861.6 4874.7 4874.9 4882.4 5042.9 5081.8 5092.7 5109.0 5122.6 4799.8 5012.3 5024.1 5085.3 5091.6 4806.3 4834.8 4838.5 4839.7 4850.5 3598.0 3603.7 3622.3 3624.1 3635.8 5084.8 5090.7 5109.4 5114.8 5157.3 4656.3 4944.2 4949.3 4954.5 4980.2 4936.1 4951.5 4953.8 4967.6 4978.0 4854.2 4862.5 4895.5 4901.4 4901.9 4643.8 4897.9 4975.5 4996.2 5032.8 4945.0 4994.4 5002.4 5022.6 5023.0 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - PROCESS | 14027 | [#5] yui.html Cycles:180 Average:12226.12 Median:43184.57 stddev:13503.13 (31.3%) stddev-sans-first:13513.58 15:22:13 INFO - PROCESS | 14027 | Values: 765.9 801.3 811.2 814.0 814.4 11072.8 11334.3 11561.4 11568.1 11582.1 11349.9 11352.8 12275.9 12579.1 12591.0 662.5 844.8 859.1 868.0 872.9 859.9 870.4 870.9 871.5 876.3 914.7 917.7 917.8 918.1 918.5 694.8 883.8 901.2 901.7 908.5 669.2 669.4 670.0 670.3 670.4 11439.3 11458.8 11465.4 11465.4 11471.4 12114.4 12334.4 12472.5 12564.4 12813.7 10912.8 11196.0 11207.7 11294.1 11636.9 4079.7 4144.3 4194.2 4239.0 4284.3 42779.1 43967.3 44416.8 44440.3 44453.0 8839.7 8843.9 9005.7 9112.5 9120.4 16299.6 16462.9 16483.5 16500.6 16510.7 6509.2 6542.1 6691.9 6700.1 6705.6 3334.6 3511.5 3576.4 3665.9 3669.8 2686.2 2770.7 2776.6 2777.2 2778.4 501.0 507.5 515.9 526.9 528.8 480.2 481.7 509.5 571.3 619.8 7166.6 7492.6 7742.5 7796.7 8008.4 572.6 587.8 594.8 612.6 615.0 3620.3 3636.5 3742.7 3762.4 3765.7 42032.4 43459.3 43629.3 43854.3 44928.8 45482.0 45602.3 46024.8 46079.3 46702.0 42010.0 42228.6 42584.0 42909.8 43504.1 7631.2 7655.8 7720.1 7856.3 8116.0 27371.7 28775.4 29168.3 29184.3 29806.0 33879.5 34610.5 36327.0 37176.0 37203.8 10254.2 10390.6 10575.0 10582.5 10607.1 11132.5 11151.4 11298.2 11858.3 11899.9 10665.7 10711.4 10753.4 11211.4 11212.0 11094.9 11110.4 11686.4 11686.9 11723.1 10676.5 10814.9 11169.1 11397.5 11432.0 8130.6 8212.5 8459.0 8473.3 8624.5 8182.2 8330.8 8576.9 8724.9 8741.5 15:22:13 INFO - PROCESS | 14027 | -------- Summary: end -------- 15:22:13 INFO - PROCESS | 14027 | 15:22:13 INFO - TEST-INFO | 14027: exit 0 15:22:13 INFO - TEST-OK | dromaeo_css | took 1119274ms 15:22:13 INFO - TEST-START | kraken 15:22:13 INFO - operating with platform_type : linux_ 15:22:13 INFO - Initialising browser for kraken test... 15:22:13 INFO - TEST-INFO | started process 14208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHQMVD0/profile http://localhost:45691/getInfo.html) 15:22:18 INFO - PROCESS | 14208 | __metrics Screen width/height:1600/1200 15:22:18 INFO - PROCESS | 14208 | colorDepth:24 15:22:18 INFO - PROCESS | 14208 | Browser inner width/height: 1024/697 15:22:18 INFO - PROCESS | 14208 | __metrics 15:22:19 ERROR - PROCESS | 14208 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:22:20 INFO - TEST-INFO | 14208: exit 0 15:22:20 INFO - Browser initialized. 15:22:20 INFO - Running cycle 1/1 for kraken test... 15:22:20 INFO - TEST-INFO | started process 14291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHQMVD0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:32 INFO - PROCESS | 14291 | RSS: Main: 154025984 15:22:32 INFO - PROCESS | 14291 | 15:22:34 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45691/tests/kraken/driver.html?testName=audio-beat-detection) 15:22:35 INFO - PROCESS | 14291 | RSS: Main: 210083840 15:22:35 INFO - PROCESS | 14291 | 15:22:38 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45691/tests/kraken/driver.html?testName=audio-dft) 15:22:39 INFO - PROCESS | 14291 | RSS: Main: 199135232 15:22:39 INFO - PROCESS | 14291 | 15:22:42 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45691/tests/kraken/driver.html?testName=audio-fft) 15:22:43 INFO - PROCESS | 14291 | RSS: Main: 266256384 15:22:43 INFO - PROCESS | 14291 | 15:22:45 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45691/tests/kraken/driver.html?testName=audio-oscillator) 15:22:46 INFO - PROCESS | 14291 | RSS: Main: 175702016 15:22:46 INFO - PROCESS | 14291 | 15:22:48 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45691/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:22:49 INFO - PROCESS | 14291 | RSS: Main: 179621888 15:22:49 INFO - PROCESS | 14291 | 15:22:52 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45691/tests/kraken/driver.html?testName=imaging-darkroom) 15:22:53 INFO - PROCESS | 14291 | RSS: Main: 215830528 15:22:53 INFO - PROCESS | 14291 | 15:22:56 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45691/tests/kraken/driver.html?testName=imaging-desaturate) 15:22:57 INFO - PROCESS | 14291 | RSS: Main: 213798912 15:22:57 INFO - PROCESS | 14291 | 15:23:00 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45691/tests/kraken/driver.html?testName=json-parse-financial) 15:23:01 INFO - PROCESS | 14291 | RSS: Main: 214462464 15:23:01 INFO - PROCESS | 14291 | 15:23:02 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45691/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:23:03 INFO - PROCESS | 14291 | RSS: Main: 210350080 15:23:03 INFO - PROCESS | 14291 | 15:23:05 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45691/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:23:06 INFO - PROCESS | 14291 | RSS: Main: 209108992 15:23:06 INFO - PROCESS | 14291 | 15:23:08 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45691/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:23:08 INFO - PROCESS | 14291 | RSS: Main: 212967424 15:23:08 INFO - PROCESS | 14291 | 15:23:11 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:23:12 INFO - PROCESS | 14291 | RSS: Main: 217870336 15:23:12 INFO - PROCESS | 14291 | 15:23:15 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:23:16 INFO - PROCESS | 14291 | RSS: Main: 217300992 15:23:16 INFO - PROCESS | 14291 | 15:23:17 INFO - PROCESS | 14291 | Cycle 1(1): loaded http://localhost:45691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45691/tests/kraken/driver.html?testName=ai-astar) 15:23:18 INFO - PROCESS | 14291 | RSS: Main: 263622656 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | __start_tp_report 15:23:18 INFO - PROCESS | 14291 | _x_x_mozilla_page_load 15:23:18 INFO - PROCESS | 14291 | _x_x_mozilla_page_load_details 15:23:18 INFO - PROCESS | 14291 | |i|pagename|runs| 15:23:18 INFO - PROCESS | 14291 | |0;ai-astar;114;109;115;116;115;114;114;114;114;116 15:23:18 INFO - PROCESS | 14291 | |1;audio-beat-detection;163;137;152;206;131;159;151;132;189;132 15:23:18 INFO - PROCESS | 14291 | |2;audio-dft;162;161;161;161;162;161;162;162;161;160 15:23:18 INFO - PROCESS | 14291 | |3;audio-fft;76;75;77;158;76;75;76;76;138;76 15:23:18 INFO - PROCESS | 14291 | |4;audio-oscillator;92;93;156;93;93;92;130;92;92;123 15:23:18 INFO - PROCESS | 14291 | |5;imaging-gaussian-blur;117;117;116;116;117;119;118;117;117;117 15:23:18 INFO - PROCESS | 14291 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;147;145 15:23:18 INFO - PROCESS | 14291 | |7;imaging-desaturate;95;95;94;95;94;94;94;95;95;94 15:23:18 INFO - PROCESS | 14291 | |8;json-parse-financial;64;65;66;65;65;68;68;65;65;65 15:23:18 INFO - PROCESS | 14291 | |9;json-stringify-tinderbox;64;64;64;65;64;64;64;64;64;64 15:23:18 INFO - PROCESS | 14291 | |10;stanford-crypto-aes;84;87;82;82;82;83;89;86;162;82 15:23:18 INFO - PROCESS | 14291 | |11;stanford-crypto-ccm;134;143;140;132;132;130;131;137;148;135 15:23:18 INFO - PROCESS | 14291 | |12;stanford-crypto-pbkdf2;174;171;173;177;175;175;170;171;167;171 15:23:18 INFO - PROCESS | 14291 | |13;stanford-crypto-sha256-iterative;67;68;72;68;67;76;67;68;65;65 15:23:18 INFO - PROCESS | 14291 | __end_tp_report 15:23:18 INFO - PROCESS | 14291 | __start_cc_report 15:23:18 INFO - PROCESS | 14291 | _x_x_mozilla_cycle_collect,2052 15:23:18 INFO - PROCESS | 14291 | __end_cc_report 15:23:18 INFO - PROCESS | 14291 | __startTimestamp1462832598130__endTimestamp 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | ------- Summary: start ------- 15:23:18 INFO - PROCESS | 14291 | Number of tests: 14 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:1.97 (1.7%) stddev-sans-first:2.09 15:23:18 INFO - PROCESS | 14291 | Values: 114.0 109.0 115.0 116.0 115.0 114.0 114.0 114.0 114.0 116.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:155.50 stddev:25.43 (16.4%) stddev-sans-first:26.81 15:23:18 INFO - PROCESS | 14291 | Values: 163.0 137.0 152.0 206.0 131.0 159.0 151.0 132.0 189.0 132.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 15:23:18 INFO - PROCESS | 14291 | Values: 162.0 161.0 161.0 161.0 162.0 161.0 162.0 162.0 161.0 160.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#3] audio-fft Cycles:10 Average:90.30 Median:76.00 stddev:30.78 (40.5%) stddev-sans-first:32.21 15:23:18 INFO - PROCESS | 14291 | Values: 76.0 75.0 77.0 158.0 76.0 75.0 76.0 76.0 138.0 76.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:92.00 stddev:22.74 (24.7%) stddev-sans-first:23.58 15:23:18 INFO - PROCESS | 14291 | Values: 92.0 93.0 156.0 93.0 93.0 92.0 130.0 92.0 92.0 123.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 15:23:18 INFO - PROCESS | 14291 | Values: 117.0 117.0 116.0 116.0 117.0 119.0 118.0 117.0 117.0 117.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:23:18 INFO - PROCESS | 14291 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 15:23:18 INFO - PROCESS | 14291 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.30 15:23:18 INFO - PROCESS | 14291 | Values: 64.0 65.0 66.0 65.0 65.0 68.0 68.0 65.0 65.0 65.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 15:23:18 INFO - PROCESS | 14291 | Values: 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 64.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:83.50 stddev:24.75 (29.6%) stddev-sans-first:26.09 15:23:18 INFO - PROCESS | 14291 | Values: 84.0 87.0 82.0 82.0 82.0 83.0 89.0 86.0 162.0 82.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:136.00 stddev:5.85 (4.3%) stddev-sans-first:6.15 15:23:18 INFO - PROCESS | 14291 | Values: 134.0 143.0 140.0 132.0 132.0 130.0 131.0 137.0 148.0 135.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:173.50 stddev:2.95 (1.7%) stddev-sans-first:3.07 15:23:18 INFO - PROCESS | 14291 | Values: 174.0 171.0 173.0 177.0 175.0 175.0 170.0 171.0 167.0 171.0 15:23:18 INFO - PROCESS | 14291 | 15:23:18 INFO - PROCESS | 14291 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:3.33 (4.9%) stddev-sans-first:3.50 15:23:18 INFO - PROCESS | 14291 | Values: 67.0 68.0 72.0 68.0 67.0 76.0 67.0 68.0 65.0 65.0 15:23:18 INFO - PROCESS | 14291 | -------- Summary: end -------- 15:23:18 INFO - PROCESS | 14291 | 15:23:19 INFO - TEST-INFO | 14291: exit 0 15:23:19 INFO - TEST-OK | kraken | took 65313ms 15:23:19 INFO - SUITE-END | took 1184s 15:23:19 INFO - Completed test suite (00:19:44) 15:23:19 INFO - javascript benchmark 15:23:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.1907768130714, 2657.508360953224, 2687.046098634986, 2705.9458810823785, 2713.782897368211, 4553.772311384434, 4614.007988282518, 4667.556582124697, 4747.7388743619085, 4802.783874725637, 4648.976755116229, 4714.5285471452835, 4727.243641017438, 4741.786619602126, 4822.6624136310475, 4297.441332626762, 4307.267764480046, 4310.331898555713, 4427.313766366218, 4430.734155950653, 4374.956250437487, 4429.0, 4465.040016396474, 4507.323901414781, 4511.187986162489, 4165.437665915093, 4383.978080109611, 4407.757573333465, 4430.977845110786, 4441.689081764262, 4222.134462435224, 4244.299690551055, 4270.295401258789, 4296.828126874952, 4301.354796780477, 4275.0594869128745, 4325.675574331937, 4335.631471324941, 4343.326784348431, 4390.078083602447, 4434.091011342699, 4622.6070783983405, 4641.373414589055, 4649.465311489154, 4652.720836749806, 4954.083494553519, 4991.875203119915, 5001.0, 5005.699658020494, 5065.1642478990925, 5009.448960614366, 5043.495650434964, 5065.366829146356, 5073.441921388644, 5080.949190508085, 4602.05657840142, 4731.763411829464, 4763.571278584944, 4766.666333356701, 4775.0, 5187.922181167285, 5272.947270527322, 5288.312519372457, 5293.814716484904, 5295.549878260314, 5031.195008798648, 5031.320771695848, 5036.345275114211, 5085.084684756705, 5090.185570308733, 4893.73084480357, 5036.0, 5113.693178409308, 5118.436971933084, 5120.206368012964, 5009.24861270805, 5033.119204139261, 5054.469280725544, 5067.290579318898, 5101.668391554611, 5040.117979353672, 5051.26756620288, 5051.87370315745, 5054.545090941833, 5110.105731496973, 4192.245395828719, 4209.074003719238, 4224.429701990253, 4355.586219309161, 4401.845935392246, 3745.9250814983548, 3778.3954567269107, 3788.412796016622, 3790.56408513019, 3825.407061905409, 4306.720063195882, 4316.115196384733, 4316.5467625899455, 4361.6510679145595, 4362.389265502832, 4842.903141937141, 5060.949390506122, 5065.138926382524, 5069.569086627678, 5116.513931176532, 4280.250956082673, 4302.397664326997, 4329.069250111241, 4342.1532801103485, 4384.188925048876, 4620.930686039712, 4621.19129152397, 4622.075584883037, 4622.144903192853, 4669.813207471663, 4635.212013957703, 4787.3537072495465, 4789.066132104206, 4801.303810947324, 4830.830920917751, 4980.626453015966, 5018.172001619692, 5020.347354843993, 5030.8239211627415, 5057.418396884405, 4717.551832575899, 4719.10337035962, 4730.136461551412, 4767.6662633615315, 4788.401449818773, 4728.71627702339, 4948.430930443045, 4975.5522003019905, 4986.376702912136, 5029.7736601852275, 5047.0, 5062.417821950523, 5083.313752643346, 5131.435542090292, 5143.6399452037995, 4941.802327906844, 4944.505549445027, 4944.851654450372, 4948.975255123702, 4991.575716064175, 4702.858914232578, 4795.256735206049, 4925.482824303396, 4926.605871530197, 4961.479044700254, 4803.087413391444, 4863.805447782049, 4880.487548807324, 4882.584980276574, 4888.144574699484, 4935.851924442272, 4937.456879743298, 4938.851834444972, 4978.925316120189, 4986.9251961221335, 4679.578837904605, 4832.1543729846435, 4836.056968891173, 4838.371011768448, 4884.535969082932], "value": 4640.891833368308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.0156733552958, 604.3744724210441, 605.7334772700015, 606.8937935861225, 618.1654766065811, 27837.0, 43523.78238108809, 43800.12399752011, 43911.0, 44070.559294407045, 43420.782896085555, 43942.34086488705, 44026.55973440265, 44071.0, 44102.33846492305, 7433.0, 7965.243301886326, 8129.918700812976, 10024.649137280197, 10399.428031458267, 10120.797584048314, 10219.28465007446, 10239.641612543563, 10240.846387304158, 10249.385036897773, 10205.132563732092, 10244.487775611227, 10256.846147307759, 10262.33294835837, 10264.178865690765, 7528.360089392381, 10031.545425913202, 10210.693679189637, 10256.74358141045, 10588.470576471145, 9951.601935922554, 10009.749756256078, 10014.298999070068, 10016.298859079867, 10027.247956403298, 40136.799316003526, 40417.0, 40426.595734042574, 40444.797776011226, 40481.79759101215, 3204.83975801209, 3246.480563109891, 3288.6053673559086, 3326.101952472819, 3572.4819901114192, 31293.0, 31582.842085789653, 31789.20526986844, 31880.521792173135, 32909.0, 3229.9677003230136, 3237.1421573282864, 3242.7243684286864, 3300.2409445827593, 3304.8843290484956, 239898.0, 240819.0, 241699.79150104313, 241737.0, 242523.0, 34524.0, 56331.338462999774, 56789.148162777594, 56799.43200568024, 56852.43147568554, 34487.4826877597, 36412.089697757765, 36450.0, 36573.08567285786, 36652.450213246826, 11463.828042579367, 13056.151350162208, 13196.0, 13212.669683257804, 13214.141080829715, 10143.340682855738, 10309.793804124025, 10330.070293673605, 10448.843267350996, 10449.111825494918, 8529.914700853036, 8540.316774658013, 8540.615672294762, 8611.440256383315, 8627.91372086271, 3216.565763621928, 3301.3397320535987, 3302.78531895426, 3325.1022223999385, 3366.848491817874, 898.3172788680649, 953.4946478366477, 999.8700168977987, 1016.5577973581516, 1045.7333379988054, 29202.707972919998, 29389.559156612668, 29455.263618409284, 29885.551716724265, 29931.551026734618, 974.8878878928872, 1037.7301901505512, 1042.9805712462378, 1067.604986155112, 1098.95050227033, 15386.230688465532, 15627.296771645304, 15772.369105235663, 15868.759992452759, 16015.119168445848, 354365.0, 359914.0, 359987.0, 360144.0, 360158.0, 51645.22532162021, 51665.741671292155, 52047.47952520502, 52240.0, 52269.0, 1128.3399211461224, 1204.9096317776377, 1229.624964385871, 1257.654145110102, 1259.2318685601776, 27753.722462775113, 29797.85101074481, 29960.80548723137, 30385.392292153592, 30686.846565767028, 43021.0, 43087.56912430836, 43519.78240108779, 43580.782096089315, 43596.56403435925, 279733.0, 280329.0, 282640.0, 283221.0, 283249.0, 23458.296251111813, 25963.22110336693, 26519.602205967312, 26736.331591710365, 26874.865625671748, 43374.78312608543, 43733.78133109314, 44184.558154418046, 44774.10451790881, 45435.09129817451, 36161.63838361583, 37205.6279437213, 37212.0, 37815.62184378121, 37981.240375192894, 37085.814570926974, 37111.0, 37113.56695507035, 37386.8130659345, 37854.0, 36480.27039459249, 36656.45015324719, 38802.80598596989, 39288.0, 39583.2083358337, 32867.178320542174, 34458.483122752674, 34727.305453891284, 35376.11559711028, 35654.108647284025, 26162.86918565395, 26654.46691066129, 26822.463550729266, 27115.505537869172, 27375.315617109733], "value": 17457.458559560695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.9644733750293, 376.6139706800529, 379.40054713552587, 390.7635880292421, 391.7668986952764, 16067.598310042255, 16075.75886361704, 17416.777099130173, 17591.208395622194, 17604.911975440104, 15885.920570397131, 16376.0, 17298.048607326593, 17302.653946921055, 17343.39298124566, 4745.501722319159, 4944.678595891256, 4971.37857767779, 4979.402471703401, 4982.501749825006, 3563.893083207495, 5387.138057910735, 5648.943510564883, 5677.261955945722, 5784.074548072309, 5672.716364181774, 5749.971250143764, 5756.165356023374, 5776.826695199151, 5789.9710501447435, 5587.798623296011, 5721.7711291548285, 5743.856403589923, 5747.655140691572, 5749.885002299951, 3389.6271410144864, 3569.089882080053, 3572.285542891432, 3577.409727394977, 5119.104156772587, 12091.516339346415, 12502.437390317458, 12597.370131493388, 12632.17890837102, 12680.365981700877, 1938.6995015772436, 2072.347210628662, 2080.251109600543, 2087.09211493001, 2223.132978138527, 9036.728898133066, 9209.171174594252, 9587.185089267421, 9750.05842079885, 9862.260330475243, 1685.578605348663, 1804.4676820338032, 1817.7182536706832, 1818.8999605021718, 1857.9163937622839, 72750.63624681842, 72792.0, 73051.26948730498, 73197.26802731905, 73231.0, 9705.805883882424, 9782.608695652236, 9888.950555247178, 10174.0, 10349.275550711529, 13120.803187952188, 13121.0, 13202.085697573799, 13213.735725285633, 13221.933890330487, 6941.34057264559, 6992.3357281058215, 6992.545484543489, 7038.788836334918, 7143.464240182007, 6700.128983232149, 6724.394804467622, 6731.562448440835, 6806.829829254309, 6888.621125838127, 4159.521655009713, 4378.671599630041, 4478.096808856223, 4559.863204103882, 4608.654350923694, 1708.1544635405553, 3140.371925614886, 3141.8114913105287, 3210.8234047127166, 3252.121927079675, 790.3835008693228, 804.3002587748696, 838.279079991207, 873.4759144513241, 995.4475266227169, 15529.378824847106, 16914.577135571464, 16954.0, 17291.0, 17430.65138697219, 901.9143181397887, 909.0182602788972, 909.1317791509093, 916.170865366844, 942.9622815087457, 9068.81862362749, 9575.760605984906, 9662.806743865223, 9707.271954603291, 9793.412395256308, 416491.0, 424756.0, 433018.0, 433155.0, 441281.0, 79820.60089699514, 80041.0, 80907.59546202232, 81069.0, 81402.0, 949.2595775295142, 956.6986399284203, 959.947202903833, 962.870012548297, 970.0978090375877, 14849.92575037118, 14855.628609284855, 14931.85068149348, 15077.246137693292, 15179.696406072038, 32218.0, 32595.348093037534, 32896.67103328936, 33028.66971330256, 34636.30727385489, 45891.77054114708, 47092.29361559648, 47356.2896556545, 47816.0, 52645.47354526406, 7564.4704870658525, 7661.770146895602, 7773.41699372538, 7800.375969922506, 7886.645100970355, 8523.616437260214, 10455.320404173704, 11289.37908415045, 11448.542058317908, 11648.126390520576, 7576.545407275581, 9363.906360936577, 9546.570404331684, 9940.652077177265, 9949.204063675033, 9696.9030309696, 9727.367721098106, 9965.0, 10001.599936002478, 10103.393796372242, 10051.949740251544, 10085.0, 10256.641017564349, 10409.0, 10621.946890265499, 7614.847703046019, 7685.0, 7708.0402661799, 7781.299683028555, 8008.238187598719, 7654.464187507044, 9713.9028609713, 10120.746981325232, 10221.9488902555, 10359.482025898826], "value": 8114.25300307618, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.9685507862296, 1469.2580246975278, 1496.0873866941165, 1657.9834201657986, 1835.4126679462577, 6916.342947419993, 7243.7826865194065, 7255.56466612003, 7388.926110738891, 7398.223186565414, 7209.243029481908, 7362.300581444768, 7367.594782286972, 7383.889241661379, 7386.630668466582, 1751.6409136127127, 2045.4068320187127, 2073.7407824022034, 2100.653392190287, 2117.4071260047212, 2058.7735349111585, 2065.401033700225, 2069.6067747128, 2071.9482012949647, 2072.1711315473854, 2036.0125339210472, 2055.342290467051, 2063.319104695447, 2064.7006184103298, 2066.3387715930908, 1980.3167907072036, 2009.2164056018164, 2040.6428874946973, 2050.6001329740707, 2051.815336619704, 2008.4978755311172, 2013.2349707111205, 2031.0555591649807, 2034.1253261097722, 2037.7045328427444, 7388.704451821921, 7446.776596702108, 7449.255074492562, 7458.328750412435, 7464.776056718307, 4269.509006464265, 4371.475422949235, 4377.080813029268, 4381.342798580238, 4416.050549131952, 2399.652050452692, 2706.648135742341, 2980.3741214345014, 2982.388610334876, 2984.2091845660916, 824.5382585751998, 965.9565319560637, 970.0541971577726, 1000.5947591225565, 1019.5463018956567, 9753.268504862164, 9766.706998790047, 9798.853017204749, 9819.656312029045, 9865.90134098657, 3945.2504024235304, 4062.756234625873, 4118.588141185857, 4124.752514849119, 4146.896327591834, 8258.174182581693, 8315.334773218128, 8315.875261871077, 8321.043080045873, 8375.748727538183, 3766.133789228493, 4582.175208462509, 4588.334691469719, 4589.173948689201, 4592.862214133581, 3907.081835768592, 4000.6599439047427, 4021.557628660845, 4023.4769479968004, 4028.778417187083, 3487.598926123528, 3558.1282585766653, 3584.6953008994005, 3593.94609080864, 3695.279420512974, 1109.522905150793, 1192.3918801411169, 1206.481213078367, 1209.2623499665197, 1210.03197442046, 866.7443104284251, 881.8412685716504, 885.4377470306401, 885.4952676974192, 893.5576889439639, 5053.216751403538, 5280.419153893069, 5335.733213339317, 5360.517553420133, 5445.401005889349, 878.4641368765048, 884.6284560484484, 899.1682693508609, 910.5811326789751, 925.9444433334022, 3550.2721942001826, 3598.1184609770776, 3620.606066664353, 3631.0, 3681.3925702258825, 8786.86819697705, 9052.27581793455, 9113.498757568397, 9194.586243619053, 9215.44707317563, 8985.955070224607, 9020.0, 9063.54682265884, 9093.863592046124, 9106.772330691785, 6603.504737144734, 6897.172339319314, 6915.204751453647, 6923.653817309215, 6924.688389022506, 5144.176931690911, 5205.531502164823, 5267.544757160982, 5321.521063104339, 5462.9180562292395, 8345.41582089248, 8347.666093356198, 8377.0, 8425.325973922194, 8587.699430519902, 8478.40651154438, 8543.572821358783, 8544.829103418022, 8590.484570925764, 8630.568471576522, 5579.832605021856, 6017.623869521405, 6100.0, 6503.804885853432, 6633.038209459698, 6734.259231484435, 6787.93212067873, 6802.727890884309, 7306.123265208209, 7398.038255026812, 6620.834479137868, 6662.533622646368, 6666.799996000128, 6763.492738044568, 6782.96608516974, 6580.21037475506, 6599.505037122139, 6604.306547812603, 6691.397774200345, 6768.661566921536, 5968.104784282219, 6001.039833626599, 6038.064100064497, 6038.969805150946, 6039.6678182698615, 4478.507364190002, 4500.752458614807, 4592.793324300348, 4617.422822147231, 4694.788734507024, 4478.753668548261, 4567.657425693153, 4581.060882519142, 4623.16782979067, 4655.534446555453], "value": 4006.1838638990234, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.9938001239975, 313.6581126572036, 317.2402096977738, 320.3864599292354, 321.1649710752046, 4851.660383773137, 4870.099031679138, 4876.36607241059, 4878.902421951559, 4892.486288939664, 4761.690490118149, 4795.616350691945, 4798.784054717537, 4815.951840481594, 4820.39745031871, 3613.8012409317475, 3750.3061933542244, 3790.7915064671433, 3841.19334939663, 3870.903227419323, 3823.5220597425323, 3856.7878766667823, 3869.284182426246, 3876.8757060452435, 3907.4920260366252, 3604.5133906922624, 3830.253100645375, 3832.2718683450057, 3840.788756618385, 3844.5578758442857, 3623.547056617923, 3742.719296052807, 3748.7188460865273, 3751.0, 3858.247641709868, 3392.1858753898887, 3419.675130862589, 3425.520427140202, 3429.828508574586, 3439.2605589798063, 4595.195840727893, 4611.0, 4629.0, 4635.443746750378, 4643.837465688718, 4291.957080429218, 4333.523312435629, 4363.847265345729, 4375.868723938287, 4413.823447062114, 4965.503449655005, 5014.373203349582, 5030.974845125787, 5047.4447810740785, 5061.063703214917, 3755.8122093895468, 3773.7169712271416, 3779.829907654162, 3781.470594116826, 3789.5263092113487, 5192.494176688756, 5299.8410047698635, 5335.4131045585345, 5374.8981458801245, 5379.462053794589, 3846.519185101806, 3848.3073046851837, 3853.479780229633, 3860.4751123306137, 3864.6908247340143, 3892.4939757831303, 3910.569837317893, 3915.5888631693833, 3927.19492504036, 3932.2528719543766, 4384.202476984421, 4384.9123017540105, 4413.933790993074, 4420.535843736426, 4426.44669416323, 4832.299316599074, 5096.9490305097215, 5110.310108135354, 5123.718195499283, 5139.97200559882, 1247.4635906560266, 1266.2529107826426, 1266.6959929616826, 1268.289757735671, 1270.2153474368527, 839.1105428246078, 871.6339137562239, 878.8637761147032, 892.7456923023162, 898.4564338575199, 4291.270484017725, 4387.144506821203, 4417.801198946056, 4418.624416924597, 4434.17967675981, 5079.161938280216, 5228.346456692913, 5242.659227150223, 5259.685078730317, 5278.841634750964, 4501.48232953208, 4504.144212599595, 4509.1658043262105, 4509.436320459942, 4511.255642818964, 2605.025520219859, 2701.446203528272, 2711.9322016949736, 2713.6200931869157, 2740.287525243451, 4787.640926930424, 4818.71087734737, 4837.677914601011, 4848.927266091011, 4879.0, 5051.0, 5147.948520514822, 5181.196914478187, 5186.273921650972, 5206.464093092547, 4857.295692124693, 4861.6353773467135, 4874.731889746027, 4874.8537543873035, 4882.36529251195, 5042.890564075898, 5081.8475445736685, 5092.726818295426, 5109.0, 5122.564582010571, 4799.784009719501, 5012.273220382951, 5024.145895197752, 5085.338905942203, 5091.574359179288, 4806.327114204084, 4834.782434790513, 4838.467768545387, 4839.685420447659, 4850.53919877611, 3598.028532296213, 3603.6756691897854, 3622.3298689742483, 3624.1483251435366, 3635.818209089588, 5084.7966081356335, 5090.694558326512, 5109.448932991535, 5114.846554603368, 5157.277981082727, 4656.278276867091, 4944.195368690474, 4949.282354058713, 4954.479779623088, 4980.203167493184, 4936.136176169228, 4951.529604687549, 4953.804795906692, 4967.6403708238295, 4977.9751101244265, 4854.247591623304, 4862.544415070367, 4895.46149923501, 4901.411830580353, 4901.90196196067, 4643.83904023994, 4897.853064407931, 4975.527324904128, 4996.150654388835, 5032.798688052437, 4944.975275123746, 4994.400671919393, 5002.424236365533, 5022.598192144546, 5022.974885125697], "value": 3818.752914812319, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.8927750114985, 801.310872649521, 811.1619051396727, 813.9715109971153, 814.3932770086286, 11072.833907491384, 11334.319940803547, 11561.421928903563, 11568.132390070736, 11582.073434125261, 11349.943250283737, 11352.829707554394, 12275.877241227585, 12579.119461637689, 12591.0, 662.5461558832216, 844.7507985144366, 859.0764927702729, 867.9566021698921, 872.8821609082788, 859.8882145321099, 870.4342177584557, 870.9303255739526, 871.4901782457271, 876.3471213945619, 914.7347269291897, 917.7246825952221, 917.7751450894507, 918.0910898210757, 918.485648037098, 694.8262934266434, 883.7746374674481, 901.2384535067857, 901.7384958362068, 908.4503875155535, 669.1568623534333, 669.4343279928453, 670.0251134599147, 670.3464122480542, 670.4167374384317, 11439.313641181472, 11458.770824583546, 11465.369404682739, 11465.426728663617, 11471.369074700888, 12114.394280285951, 12334.444949977273, 12472.50109995599, 12564.434600443003, 12813.679658008532, 10912.836307455394, 11196.0, 11207.719807004809, 11294.096472282197, 11636.94181529087, 4079.73481723687, 4144.295469770116, 4194.2450358935375, 4238.957610423918, 4284.271673815459, 42779.144417111485, 43967.340489892355, 44416.777916110535, 44440.3333949991, 44453.0, 8839.69061082859, 8843.867341989875, 9005.684801032063, 9112.450883349846, 9120.407173533698, 16299.59251018734, 16462.917685411496, 16483.505494835175, 16500.587485312724, 16510.66978660444, 6509.153810004764, 6542.149520562297, 6691.866162676719, 6700.095487109178, 6705.564138330993, 3334.6498617645284, 3511.5083888255663, 3576.3562558739677, 3665.9450108248398, 3669.7614655047337, 2686.1672881406826, 2770.667519897625, 2776.625155604008, 2777.1946135620847, 2778.374865655252, 500.9524095210949, 507.50771751401084, 515.9277701121846, 526.9446708095671, 528.7541293298634, 480.2148487223345, 481.7470827815355, 509.53254626674936, 571.3115695586891, 619.7706848466006, 7166.605836679033, 7492.550446973199, 7742.496737712031, 7796.688132474751, 8008.359331253486, 572.6163470474792, 587.8412828536357, 594.7591225553658, 612.5956868466791, 614.97232624532, 3620.2759448110482, 3636.509071275344, 3742.6631603155847, 3762.4168253920684, 3765.736398452082, 42032.36951445731, 43459.34810977838, 43629.345559816626, 43854.34218486725, 44928.77535612301, 45482.0, 45602.31596526055, 46024.76987615041, 46079.308810367875, 46702.0, 42010.0, 42228.57771422246, 42584.0, 42909.785451072545, 43504.12991740147, 7631.236876312324, 7655.770326890202, 7720.112187098555, 7856.25365590268, 8115.959420202861, 27371.72628273692, 28775.424491509635, 29168.27079323034, 29184.27039323949, 29806.0, 33879.49180762241, 34610.48084278788, 36327.0, 37176.0, 37203.813980931, 10254.230932680228, 10390.584376625153, 10575.0, 10582.470876455993, 10607.098396636373, 11132.499037543492, 11151.386673733023, 11298.209125361145, 11858.347790871585, 11899.940500297444, 10665.733356666145, 10711.357318560911, 10753.354798712102, 11211.383373914514, 11212.0, 11094.889051109385, 11110.388928609003, 11686.415679216176, 11686.94156529212, 11723.062155027748, 10676.519556620126, 10814.89185108139, 11169.050630696482, 11397.544098235978, 11432.0, 8130.5915874629645, 8212.548309843016, 8458.957705211435, 8473.322134229124, 8624.482531048157, 8182.218045864197, 8330.791730206793, 8576.914230857612, 8724.91275087241, 8741.475511469333], "value": 5864.443108605792, "unit": "score"}], "name": "dromaeo_css", "value": 6239.169560860308, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 115.0, 116.0, 115.0, 114.0, 114.0, 114.0, 114.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 137.0, 152.0, 206.0, 131.0, 159.0, 151.0, 132.0, 189.0, 132.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 158.0, 76.0, 75.0, 76.0, 76.0, 138.0, 76.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 156.0, 93.0, 93.0, 92.0, 130.0, 92.0, 92.0, 123.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 119.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 65.0, 65.0, 68.0, 68.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 82.0, 82.0, 82.0, 83.0, 89.0, 86.0, 162.0, 82.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 140.0, 132.0, 132.0, 130.0, 131.0, 137.0, 148.0, 135.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 173.0, 177.0, 175.0, 175.0, 170.0, 171.0, 167.0, 171.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 72.0, 68.0, 67.0, 76.0, 67.0, 68.0, 65.0, 65.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1582.7, "alertThreshold": 2.0}]} 15:23:19 INFO - Return code: 0 15:23:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:23:19 ERROR - # TBPL SUCCESS # 15:23:19 INFO - Running post-action listener: _resource_record_post_action 15:23:19 INFO - ##### 15:23:19 INFO - ##### Finished run-tests step (success) 15:23:19 INFO - ##### 15:23:19 INFO - Running post-run listener: _resource_record_post_run 15:23:20 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534888448; Read time: 108; Write time: 425900 15:23:20 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246292480; Read time: 0; Write time: 254780 15:23:20 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288595968; Read time: 108; Write time: 171120 15:23:20 INFO - Running post-run listener: _upload_blobber_files 15:23:20 INFO - Blob upload gear active. 15:23:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:23:20 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 15:23:20 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'] 15:23:20 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 15:23:20 INFO - (blobuploader) - INFO - Open directory for files ... 15:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:23:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:21 INFO - (blobuploader) - INFO - Done attempting. 15:23:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:23:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:23:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:22 INFO - (blobuploader) - INFO - Done attempting. 15:23:22 INFO - (blobuploader) - INFO - Iteration through files over. 15:23:22 INFO - Return code: 0 15:23:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:23:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:23:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e196f7916079f8f34ee0bdc50a80ee51eecb935be749a550b4fc33533e499d504345f28c479c8965c564beec08457674402610b0e3046edda6e754cec131dcfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/804b3df0e461716e96a710a9b6039b542a3f623ad0c1f93e2a269f0f3fb9e7189e44b913b3efd0e73c07ef61fd5c590f5bd8985fabc9f70211ff85d3c6a8bed3"} 15:23:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:23:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:23:22 INFO - Contents: 15:23:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e196f7916079f8f34ee0bdc50a80ee51eecb935be749a550b4fc33533e499d504345f28c479c8965c564beec08457674402610b0e3046edda6e754cec131dcfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/804b3df0e461716e96a710a9b6039b542a3f623ad0c1f93e2a269f0f3fb9e7189e44b913b3efd0e73c07ef61fd5c590f5bd8985fabc9f70211ff85d3c6a8bed3"} 15:23:22 INFO - Running post-run listener: copy_logs_to_upload_dir 15:23:22 INFO - Copying logs to upload dir... 15:23:22 INFO - mkdir: /builds/slave/test/build/upload/logs 15:23:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.227714 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-09 15:23:22.407795) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 15:23:22.411079) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923 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/e196f7916079f8f34ee0bdc50a80ee51eecb935be749a550b4fc33533e499d504345f28c479c8965c564beec08457674402610b0e3046edda6e754cec131dcfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/804b3df0e461716e96a710a9b6039b542a3f623ad0c1f93e2a269f0f3fb9e7189e44b913b3efd0e73c07ef61fd5c590f5bd8985fabc9f70211ff85d3c6a8bed3"} build_url:https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/O4pIPjbQSPWE9jlpjaHLRA/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/e196f7916079f8f34ee0bdc50a80ee51eecb935be749a550b4fc33533e499d504345f28c479c8965c564beec08457674402610b0e3046edda6e754cec131dcfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/804b3df0e461716e96a710a9b6039b542a3f623ad0c1f93e2a269f0f3fb9e7189e44b913b3efd0e73c07ef61fd5c590f5bd8985fabc9f70211ff85d3c6a8bed3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 15:23:22.435362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:23:22.435670) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1462831361.823157-698464923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:23:22.518475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 15:23:22.518806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 15:23:22.519096) ========= ========= Total master_lag: 0.16 =========