builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1462908640.9 results: success (0) buildid: 20160510053023 builduid: 40f53433b97442bd80d293afc53d3ee5 revision: 2f9351bae69d056e4615d21dda6bf42fec5d16b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:40.896717) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:40.897190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:40.897484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:40.925067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:40.925333) ========= 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=652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 12:30:41-- 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% 31.8M=0s 2016-05-10 12:30:41 (31.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119861 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.058421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.058744) ========= 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=652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018598 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.108721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.109086) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f9351bae69d056e4615d21dda6bf42fec5d16b7 --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 2f9351bae69d056e4615d21dda6bf42fec5d16b7 --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=652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 12:30:41,377 truncating revision to first 12 chars 2016-05-10 12:30:41,377 Setting DEBUG logging. 2016-05-10 12:30:41,377 attempt 1/10 2016-05-10 12:30:41,377 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f9351bae69d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 12:30:41,798 unpacking tar archive at: fx-team-2f9351bae69d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721483 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.845400) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.845837) ========= script_repo_revision: 2f9351bae69d056e4615d21dda6bf42fec5d16b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.846317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.846646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 12:30:41.974783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-10 12:30:41.975205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:30:42 INFO - MultiFileLogger online at 20160510 12:30:42 in /builds/slave/test 12:30:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:30:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:30:42 INFO - {'append_to_log': False, 12:30:42 INFO - 'base_work_dir': '/builds/slave/test', 12:30:42 INFO - 'blob_upload_branch': 'Fx-Team', 12:30:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:30:42 INFO - 'branch': 'Fx-Team', 12:30:42 INFO - 'buildbot_json_path': 'buildprops.json', 12:30:42 INFO - 'config_files': ('talos/linux_config.py',), 12:30:42 INFO - 'default_actions': ('clobber', 12:30:42 INFO - 'read-buildbot-config', 12:30:42 INFO - 'download-and-extract', 12:30:42 INFO - 'populate-webroot', 12:30:42 INFO - 'create-virtualenv', 12:30:42 INFO - 'install', 12:30:42 INFO - 'run-tests'), 12:30:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:30:42 INFO - 'download_minidump_stackwalk': True, 12:30:42 INFO - 'download_symbols': 'ondemand', 12:30:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:30:42 INFO - 'tooltool.py': '/tools/tooltool.py', 12:30:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:30:42 INFO - '/tools/misc-python/virtualenv.py')}, 12:30:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:30:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:30:42 INFO - 'installer_path': 'installer.exe', 12:30:42 INFO - 'log_level': 'info', 12:30:42 INFO - 'log_name': 'talos', 12:30:42 INFO - 'log_to_console': True, 12:30:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:30:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:30:42 INFO - 'opt_config_files': (), 12:30:42 INFO - 'pip_index': False, 12:30:42 INFO - 'sps_profile': False, 12:30:42 INFO - 'sps_profile_interval': 0, 12:30:42 INFO - 'suite': 'dromaeojs', 12:30:42 INFO - 'system_bits': '32', 12:30:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:30:42 INFO - 'title': 'talos-linux64-ix-046', 12:30:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:30:42 INFO - 'use_talos_json': True, 12:30:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:30:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:30:42 INFO - 'work_dir': 'build'} 12:30:42 INFO - ##### 12:30:42 INFO - ##### Running clobber step. 12:30:42 INFO - ##### 12:30:42 INFO - Running pre-action listener: _resource_record_pre_action 12:30:42 INFO - Running main action method: clobber 12:30:42 INFO - rmtree: /builds/slave/test/build 12:30:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:30:42 INFO - Running post-action listener: _resource_record_post_action 12:30:42 INFO - ##### 12:30:42 INFO - ##### Finished clobber step (success) 12:30:42 INFO - ##### 12:30:42 INFO - ##### 12:30:42 INFO - ##### Running read-buildbot-config step. 12:30:42 INFO - ##### 12:30:42 INFO - Running pre-action listener: _resource_record_pre_action 12:30:42 INFO - Running main action method: read_buildbot_config 12:30:42 INFO - Using buildbot properties: 12:30:42 INFO - { 12:30:42 INFO - "project": "", 12:30:42 INFO - "product": "firefox", 12:30:42 INFO - "script_repo_revision": "production", 12:30:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:30:42 INFO - "repository": "", 12:30:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:30:42 INFO - "buildid": "20160510053023", 12:30:42 INFO - "pgo_build": "True", 12:30:42 INFO - "basedir": "/builds/slave/test", 12:30:42 INFO - "buildnumber": 1139, 12:30:42 INFO - "slavename": "talos-linux64-ix-046", 12:30:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:30:42 INFO - "platform": "ubuntu64_hw", 12:30:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:30:42 INFO - "branch": "fx-team", 12:30:42 INFO - "repo_path": "integration/fx-team", 12:30:42 INFO - "revision": "2f9351bae69d056e4615d21dda6bf42fec5d16b7", 12:30:42 INFO - "stage_platform": "linux64-pgo", 12:30:42 INFO - "builduid": "40f53433b97442bd80d293afc53d3ee5", 12:30:42 INFO - "slavebuilddir": "test" 12:30:42 INFO - } 12:30:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:30:42 INFO - Running post-action listener: _resource_record_post_action 12:30:42 INFO - ##### 12:30:42 INFO - ##### Finished read-buildbot-config step (success) 12:30:42 INFO - ##### 12:30:42 INFO - ##### 12:30:42 INFO - ##### Running download-and-extract step. 12:30:42 INFO - ##### 12:30:42 INFO - Running pre-action listener: _resource_record_pre_action 12:30:42 INFO - Running main action method: download_and_extract 12:30:42 INFO - mkdir: /builds/slave/test/build/tests 12:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:42 INFO - https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:30:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:30:47 INFO - Downloaded 1361 bytes. 12:30:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:47 INFO - Using the following test package requirements: 12:30:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:30:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:30:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:47 INFO - u'jsshell-linux-x86_64.zip'], 12:30:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:30:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:30:47 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:30:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:30:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:30:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:47 INFO - https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:30:50 INFO - Downloaded 23898949 bytes. 12:30:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:30:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:30:51 INFO - Return code: 0 12:30:51 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 12:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:30:51 INFO - https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:30:58 INFO - Downloaded 23898949 bytes. 12:30:58 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'] 12:30:58 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 12:31:00 INFO - Return code: 0 12:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:00 INFO - https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:31:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:31:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:31:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:31:01 INFO - Downloaded 10840152 bytes. 12:31:01 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'] 12:31:01 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 12:31:01 INFO - Return code: 0 12:31: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')]} 12:31:01 INFO - https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:31:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:31:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:31:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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 12:31:02 INFO - Downloaded 58322556 bytes. 12:31:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:31:02 INFO - mkdir: /builds/slave/test/properties 12:31:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:31:02 INFO - Writing to file /builds/slave/test/properties/build_url 12:31:02 INFO - Contents: 12:31:02 INFO - build_url:https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:31:04 INFO - Running post-action listener: _resource_record_post_action 12:31:04 INFO - Running post-action listener: set_extra_try_arguments 12:31:04 INFO - ##### 12:31:04 INFO - ##### Finished download-and-extract step (success) 12:31:04 INFO - ##### 12:31:04 INFO - ##### 12:31:04 INFO - ##### Running populate-webroot step. 12:31:04 INFO - ##### 12:31:04 INFO - Running pre-action listener: _resource_record_pre_action 12:31:04 INFO - Running main action method: populate_webroot 12:31:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:31:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:31:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:31:04 INFO - '--tppagecycles', 12:31:04 INFO - '7'], 12:31:04 INFO - 'tests': ['tsvgm']}}, 12:31:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:31:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:31:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:31:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:31:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:04 INFO - 'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:04 INFO - 'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['damp', 'tps']}, 12:31:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:04 INFO - 'tests': ['damp', 'tps']}, 12:31:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['dromaeo_dom']}, 12:31:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:31:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['a11yr', 12:31:04 INFO - 'ts_paint', 12:31:04 INFO - 'tpaint', 12:31:04 INFO - 'sessionrestore', 12:31:04 INFO - 'sessionrestore_no_auto_restore', 12:31:04 INFO - 'tabpaint']}, 12:31:04 INFO - 'other-e10s': {'tests': ['a11yr', 12:31:04 INFO - 'ts_paint', 12:31:04 INFO - 'tpaint', 12:31:04 INFO - 'sessionrestore', 12:31:04 INFO - 'sessionrestore_no_auto_restore', 12:31:04 INFO - 'tabpaint']}, 12:31:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:31:04 INFO - 'ts_paint', 12:31:04 INFO - 'tpaint', 12:31:04 INFO - 'sessionrestore', 12:31:04 INFO - 'sessionrestore_no_auto_restore', 12:31:04 INFO - 'tabpaint']}, 12:31:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:31:04 INFO - 'ts_paint', 12:31:04 INFO - 'tpaint', 12:31:04 INFO - 'sessionrestore', 12:31:04 INFO - 'sessionrestore_no_auto_restore', 12:31:04 INFO - 'tabpaint']}, 12:31:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['a11yr', 12:31:04 INFO - 'ts_paint', 12:31:04 INFO - 'tpaint', 12:31:04 INFO - 'sessionrestore', 12:31:04 INFO - 'sessionrestore_no_auto_restore', 12:31:04 INFO - 'tabpaint']}, 12:31:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['a11yr', 12:31:04 INFO - 'ts_paint', 12:31:04 INFO - 'tpaint', 12:31:04 INFO - 'sessionrestore', 12:31:04 INFO - 'sessionrestore_no_auto_restore', 12:31:04 INFO - 'tabpaint']}, 12:31:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['tsvgx', 12:31:04 INFO - 'tsvgr_opacity', 12:31:04 INFO - 'tart', 12:31:04 INFO - 'tscrollx', 12:31:04 INFO - 'cart']}, 12:31:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:31:04 INFO - 'tsvgr_opacity', 12:31:04 INFO - 'tart', 12:31:04 INFO - 'tscrollx', 12:31:04 INFO - 'cart']}, 12:31:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:04 INFO - 'talos_options': ['--disable-e10s'], 12:31:04 INFO - 'tests': ['tp5o']}, 12:31:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:04 INFO - 'tests': ['tp5o']}, 12:31:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:04 INFO - 'talos_options': ['--disable-e10s', 12:31:04 INFO - '--xperf_path', 12:31:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:04 INFO - 'tests': ['tp5n']}, 12:31:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:04 INFO - 'talos_options': ['--xperf_path', 12:31:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:04 INFO - 'tests': ['tp5n']}}, 12:31:04 INFO - 'talos.zip': {'path': '', 12:31:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:31:04 INFO - Running post-action listener: _resource_record_post_action 12:31:04 INFO - ##### 12:31:04 INFO - ##### Finished populate-webroot step (success) 12:31:04 INFO - ##### 12:31:04 INFO - ##### 12:31:04 INFO - ##### Running create-virtualenv step. 12:31:04 INFO - ##### 12:31:04 INFO - Running pre-action listener: _resource_record_pre_action 12:31:04 INFO - Running main action method: create_virtualenv 12:31:04 INFO - Creating virtualenv /builds/slave/test/build/venv 12:31:04 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 12:31:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:31:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:31:04 INFO - Using real prefix '/usr' 12:31:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:31:04 INFO - Installing distribute.............................................................................................................................................................................................done. 12:31:06 INFO - Installing pip.................done. 12:31:06 INFO - Return code: 0 12:31:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:31:06 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')]} 12:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:06 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')]} 12:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:06 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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31:06 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 12:31:06 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 12:31:06 INFO - Using env: {'DISPLAY': ':0', 12:31:06 INFO - 'HOME': '/home/cltbld', 12:31:06 INFO - 'LANG': 'en_US.UTF-8', 12:31:06 INFO - 'LANGUAGE': 'en_US:en', 12:31:06 INFO - 'LOGNAME': 'cltbld', 12:31:06 INFO - 'MAIL': '/var/mail/cltbld', 12:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:06 INFO - 'MOZ_NO_REMOTE': '1', 12:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:06 INFO - 'NO_EM_RESTART': '1', 12:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:06 INFO - 'PWD': '/builds/slave/test', 12:31:06 INFO - 'SHELL': '/bin/bash', 12:31:06 INFO - 'SHLVL': '1', 12:31:06 INFO - 'TERM': 'linux', 12:31:06 INFO - 'TMOUT': '86400', 12:31:06 INFO - 'USER': 'cltbld', 12:31:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:06 INFO - '_': '/tools/buildbot/bin/python'} 12:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:06 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 12:31:06 INFO - Cleaning up... 12:31:06 INFO - Return code: 0 12:31:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:31:06 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')]} 12:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:06 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')]} 12:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:06 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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31:06 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 12:31:06 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 12:31:06 INFO - Using env: {'DISPLAY': ':0', 12:31:06 INFO - 'HOME': '/home/cltbld', 12:31:06 INFO - 'LANG': 'en_US.UTF-8', 12:31:06 INFO - 'LANGUAGE': 'en_US:en', 12:31:06 INFO - 'LOGNAME': 'cltbld', 12:31:06 INFO - 'MAIL': '/var/mail/cltbld', 12:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:06 INFO - 'MOZ_NO_REMOTE': '1', 12:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:06 INFO - 'NO_EM_RESTART': '1', 12:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:06 INFO - 'PWD': '/builds/slave/test', 12:31:06 INFO - 'SHELL': '/bin/bash', 12:31:06 INFO - 'SHLVL': '1', 12:31:06 INFO - 'TERM': 'linux', 12:31:06 INFO - 'TMOUT': '86400', 12:31:06 INFO - 'USER': 'cltbld', 12:31:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:06 INFO - '_': '/tools/buildbot/bin/python'} 12:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:07 INFO - Downloading/unpacking psutil>=0.7.1 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:31:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:09 INFO - Installing collected packages: psutil 12:31:09 INFO - Running setup.py install for psutil 12:31:09 INFO - building 'psutil._psutil_linux' extension 12:31:09 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 12:31:09 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 12:31:09 INFO - building 'psutil._psutil_posix' extension 12:31:09 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 12:31:09 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 12:31:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:09 INFO - Successfully installed psutil 12:31:09 INFO - Cleaning up... 12:31:09 INFO - Return code: 0 12:31:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:31:09 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')]} 12:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:09 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')]} 12:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:09 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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31:09 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 12:31:09 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 12:31:09 INFO - Using env: {'DISPLAY': ':0', 12:31:09 INFO - 'HOME': '/home/cltbld', 12:31:09 INFO - 'LANG': 'en_US.UTF-8', 12:31:09 INFO - 'LANGUAGE': 'en_US:en', 12:31:09 INFO - 'LOGNAME': 'cltbld', 12:31:09 INFO - 'MAIL': '/var/mail/cltbld', 12:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:09 INFO - 'MOZ_NO_REMOTE': '1', 12:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:09 INFO - 'NO_EM_RESTART': '1', 12:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:09 INFO - 'PWD': '/builds/slave/test', 12:31:09 INFO - 'SHELL': '/bin/bash', 12:31:09 INFO - 'SHLVL': '1', 12:31:09 INFO - 'TERM': 'linux', 12:31:09 INFO - 'TMOUT': '86400', 12:31:09 INFO - 'USER': 'cltbld', 12:31:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:09 INFO - '_': '/tools/buildbot/bin/python'} 12:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:31:11 INFO - Installing collected packages: mozsystemmonitor 12:31:11 INFO - Running setup.py install for mozsystemmonitor 12:31:11 INFO - Successfully installed mozsystemmonitor 12:31:11 INFO - Cleaning up... 12:31:11 INFO - Return code: 0 12:31:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:31: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')]} 12:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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')]} 12:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31: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', '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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:31: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 blobuploader==1.2.4 12:31:11 INFO - Using env: {'DISPLAY': ':0', 12:31:11 INFO - 'HOME': '/home/cltbld', 12:31:11 INFO - 'LANG': 'en_US.UTF-8', 12:31:11 INFO - 'LANGUAGE': 'en_US:en', 12:31:11 INFO - 'LOGNAME': 'cltbld', 12:31:11 INFO - 'MAIL': '/var/mail/cltbld', 12:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:11 INFO - 'MOZ_NO_REMOTE': '1', 12:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:11 INFO - 'NO_EM_RESTART': '1', 12:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:11 INFO - 'PWD': '/builds/slave/test', 12:31:11 INFO - 'SHELL': '/bin/bash', 12:31:11 INFO - 'SHLVL': '1', 12:31:11 INFO - 'TERM': 'linux', 12:31:11 INFO - 'TMOUT': '86400', 12:31:11 INFO - 'USER': 'cltbld', 12:31:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:11 INFO - '_': '/tools/buildbot/bin/python'} 12:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:12 INFO - Downloading/unpacking blobuploader==1.2.4 12:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:13 INFO - Downloading blobuploader-1.2.4.tar.gz 12:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:31:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:31:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:14 INFO - Downloading docopt-0.6.1.tar.gz 12:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:31:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:31:14 INFO - Running setup.py install for blobuploader 12:31:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:31:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:31:14 INFO - Running setup.py install for requests 12:31:15 INFO - Running setup.py install for docopt 12:31:15 INFO - Successfully installed blobuploader requests docopt 12:31:15 INFO - Cleaning up... 12:31:15 INFO - Return code: 0 12:31:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:15 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')]} 12:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:15 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')]} 12:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:15 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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31:15 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 12:31:15 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 12:31:15 INFO - Using env: {'DISPLAY': ':0', 12:31:15 INFO - 'HOME': '/home/cltbld', 12:31:15 INFO - 'LANG': 'en_US.UTF-8', 12:31:15 INFO - 'LANGUAGE': 'en_US:en', 12:31:15 INFO - 'LOGNAME': 'cltbld', 12:31:15 INFO - 'MAIL': '/var/mail/cltbld', 12:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:15 INFO - 'MOZ_NO_REMOTE': '1', 12:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:15 INFO - 'NO_EM_RESTART': '1', 12:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:15 INFO - 'PWD': '/builds/slave/test', 12:31:15 INFO - 'SHELL': '/bin/bash', 12:31:15 INFO - 'SHLVL': '1', 12:31:15 INFO - 'TERM': 'linux', 12:31:15 INFO - 'TMOUT': '86400', 12:31:15 INFO - 'USER': 'cltbld', 12:31:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:15 INFO - '_': '/tools/buildbot/bin/python'} 12:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:15 INFO - Running setup.py (path:/tmp/pip-kzUSJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:15 INFO - Running setup.py (path:/tmp/pip-wF568M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:15 INFO - Running setup.py (path:/tmp/pip-m8Yvms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:15 INFO - Running setup.py (path:/tmp/pip-GNEUut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:15 INFO - Running setup.py (path:/tmp/pip-3n3qyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:15 INFO - Running setup.py (path:/tmp/pip-g_no6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:16 INFO - Running setup.py (path:/tmp/pip-5saVby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:16 INFO - Running setup.py (path:/tmp/pip-4Qavd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:16 INFO - Running setup.py (path:/tmp/pip-eGyYUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:16 INFO - Running setup.py (path:/tmp/pip-mbgSTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:16 INFO - Running setup.py (path:/tmp/pip-qj_277-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:16 INFO - Running setup.py (path:/tmp/pip-h4IhBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:16 INFO - Running setup.py (path:/tmp/pip-nEQBcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:16 INFO - Running setup.py (path:/tmp/pip-xDtPXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:16 INFO - Running setup.py (path:/tmp/pip-PvtQnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:16 INFO - Running setup.py (path:/tmp/pip-NTiB7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:16 INFO - Running setup.py (path:/tmp/pip-yYdapi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:31:16 INFO - Running setup.py install for manifestparser 12:31:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:31:16 INFO - Running setup.py install for mozcrash 12:31:17 INFO - Running setup.py install for mozdebug 12:31:17 INFO - Running setup.py install for mozdevice 12:31:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Running setup.py install for mozfile 12:31:17 INFO - Running setup.py install for mozhttpd 12:31:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Running setup.py install for mozinfo 12:31:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Running setup.py install for mozInstall 12:31:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Running setup.py install for mozleak 12:31:17 INFO - Running setup.py install for mozlog 12:31:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Running setup.py install for moznetwork 12:31:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:31:17 INFO - Running setup.py install for mozprocess 12:31:18 INFO - Running setup.py install for mozprofile 12:31:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:31:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:31:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:31:18 INFO - Running setup.py install for mozrunner 12:31:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:31:18 INFO - Running setup.py install for mozscreenshot 12:31:18 INFO - Running setup.py install for moztest 12:31:18 INFO - Running setup.py install for mozversion 12:31:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:31:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:31:18 INFO - Cleaning up... 12:31:18 INFO - Return code: 0 12:31:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:18 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')]} 12:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:18 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')]} 12:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:18 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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31:18 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 12:31:18 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 12:31:18 INFO - Using env: {'DISPLAY': ':0', 12:31:18 INFO - 'HOME': '/home/cltbld', 12:31:18 INFO - 'LANG': 'en_US.UTF-8', 12:31:18 INFO - 'LANGUAGE': 'en_US:en', 12:31:18 INFO - 'LOGNAME': 'cltbld', 12:31:18 INFO - 'MAIL': '/var/mail/cltbld', 12:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:18 INFO - 'MOZ_NO_REMOTE': '1', 12:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:18 INFO - 'NO_EM_RESTART': '1', 12:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:18 INFO - 'PWD': '/builds/slave/test', 12:31:18 INFO - 'SHELL': '/bin/bash', 12:31:18 INFO - 'SHLVL': '1', 12:31:18 INFO - 'TERM': 'linux', 12:31:18 INFO - 'TMOUT': '86400', 12:31:18 INFO - 'USER': 'cltbld', 12:31:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:18 INFO - '_': '/tools/buildbot/bin/python'} 12:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:18 INFO - Running setup.py (path:/tmp/pip-G4nlzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:18 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)) 12:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:18 INFO - Running setup.py (path:/tmp/pip-KtM1hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:18 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)) 12:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:18 INFO - Running setup.py (path:/tmp/pip-vjFP9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:19 INFO - Running setup.py (path:/tmp/pip-JU77To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:19 INFO - Running setup.py (path:/tmp/pip-oOHus7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:19 INFO - Running setup.py (path:/tmp/pip-nZYPxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:19 INFO - Running setup.py (path:/tmp/pip-ldfX1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:19 INFO - Running setup.py (path:/tmp/pip-DeJjiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:19 INFO - Running setup.py (path:/tmp/pip-D56k4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:19 INFO - Running setup.py (path:/tmp/pip-G_njjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:19 INFO - Running setup.py (path:/tmp/pip-KTjr06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:19 INFO - Running setup.py (path:/tmp/pip-kqbKRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:19 INFO - Running setup.py (path:/tmp/pip-LzZ14J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:19 INFO - Running setup.py (path:/tmp/pip-9MDdeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:19 INFO - Running setup.py (path:/tmp/pip-ks4yNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:19 INFO - Running setup.py (path:/tmp/pip-PNsKzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:19 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)) 12:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:19 INFO - Running setup.py (path:/tmp/pip-9eN1sA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:20 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)) 12:31:20 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)) 12:31:20 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)) 12:31:20 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)) 12:31:20 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)) 12:31:20 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)) 12:31:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:20 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 12:31:20 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 12:31:20 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 12:31:20 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 12:31:20 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 12:31:20 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 12:31:21 INFO - Downloading blessings-1.6.tar.gz 12:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:31:21 INFO - Installing collected packages: blessings 12:31:21 INFO - Running setup.py install for blessings 12:31:22 INFO - Successfully installed blessings 12:31:22 INFO - Cleaning up... 12:31:22 INFO - Return code: 0 12:31:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:22 INFO - Reading from file tmpfile_stdout 12:31:22 INFO - Current package versions: 12:31:22 INFO - argparse == 1.2.1 12:31:22 INFO - blessings == 1.6 12:31:22 INFO - blobuploader == 1.2.4 12:31:22 INFO - docopt == 0.6.1 12:31:22 INFO - manifestparser == 1.1 12:31:22 INFO - mozInstall == 1.12 12:31:22 INFO - mozcrash == 0.17 12:31:22 INFO - mozdebug == 0.1 12:31:22 INFO - mozdevice == 0.48 12:31:22 INFO - mozfile == 1.2 12:31:22 INFO - mozhttpd == 0.7 12:31:22 INFO - mozinfo == 0.9 12:31:22 INFO - mozleak == 0.1 12:31:22 INFO - mozlog == 3.1 12:31:22 INFO - moznetwork == 0.27 12:31:22 INFO - mozprocess == 0.22 12:31:22 INFO - mozprofile == 0.28 12:31:22 INFO - mozrunner == 6.11 12:31:22 INFO - mozscreenshot == 0.1 12:31:22 INFO - mozsystemmonitor == 0.0 12:31:22 INFO - moztest == 0.7 12:31:22 INFO - mozversion == 1.4 12:31:22 INFO - psutil == 3.1.1 12:31:22 INFO - requests == 1.2.3 12:31:22 INFO - wsgiref == 0.1.2 12:31:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:22 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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31:22 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 12:31:22 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 12:31:22 INFO - Using env: {'DISPLAY': ':0', 12:31:22 INFO - 'HOME': '/home/cltbld', 12:31:22 INFO - 'LANG': 'en_US.UTF-8', 12:31:22 INFO - 'LANGUAGE': 'en_US:en', 12:31:22 INFO - 'LOGNAME': 'cltbld', 12:31:22 INFO - 'MAIL': '/var/mail/cltbld', 12:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:22 INFO - 'MOZ_NO_REMOTE': '1', 12:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:22 INFO - 'NO_EM_RESTART': '1', 12:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:22 INFO - 'PWD': '/builds/slave/test', 12:31:22 INFO - 'SHELL': '/bin/bash', 12:31:22 INFO - 'SHLVL': '1', 12:31:22 INFO - 'TERM': 'linux', 12:31:22 INFO - 'TMOUT': '86400', 12:31:22 INFO - 'USER': 'cltbld', 12:31:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:22 INFO - '_': '/tools/buildbot/bin/python'} 12:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 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)) 12:31:22 INFO - Cleaning up... 12:31:22 INFO - Return code: 0 12:31:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:22 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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31:22 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 12:31:22 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 12:31:22 INFO - Using env: {'DISPLAY': ':0', 12:31:22 INFO - 'HOME': '/home/cltbld', 12:31:22 INFO - 'LANG': 'en_US.UTF-8', 12:31:22 INFO - 'LANGUAGE': 'en_US:en', 12:31:22 INFO - 'LOGNAME': 'cltbld', 12:31:22 INFO - 'MAIL': '/var/mail/cltbld', 12:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:22 INFO - 'MOZ_NO_REMOTE': '1', 12:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:22 INFO - 'NO_EM_RESTART': '1', 12:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:22 INFO - 'PWD': '/builds/slave/test', 12:31:22 INFO - 'SHELL': '/bin/bash', 12:31:22 INFO - 'SHLVL': '1', 12:31:22 INFO - 'TERM': 'linux', 12:31:22 INFO - 'TMOUT': '86400', 12:31:22 INFO - 'USER': 'cltbld', 12:31:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:22 INFO - '_': '/tools/buildbot/bin/python'} 12:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:22 INFO - Downloading/unpacking jsonschema 12:31:22 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 12:31:22 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 12:31:22 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 12:31:22 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 12:31:22 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 12:31:22 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 12:31:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:24 INFO - Downloading/unpacking functools32 (from jsonschema) 12:31:24 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 12:31:24 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 12:31:24 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 12:31:24 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 12:31:24 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 12:31:24 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 12:31:24 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:24 INFO - warning: no files found matching '*.txt' 12:31:24 INFO - no previously-included directories found matching 'build' 12:31:24 INFO - no previously-included directories found matching 'dist' 12:31:24 INFO - no previously-included directories found matching '.git*' 12:31:24 INFO - Installing collected packages: jsonschema, functools32 12:31:25 INFO - Running setup.py install for functools32 12:31:25 INFO - warning: no files found matching '*.txt' 12:31:25 INFO - no previously-included directories found matching 'build' 12:31:25 INFO - no previously-included directories found matching 'dist' 12:31:25 INFO - no previously-included directories found matching '.git*' 12:31:25 INFO - Successfully installed jsonschema functools32 12:31:25 INFO - Cleaning up... 12:31:25 INFO - Return code: 0 12:31:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:25 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 0x7ffa678c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1967770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', '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 12:31:25 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 12:31:25 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 12:31:25 INFO - Using env: {'DISPLAY': ':0', 12:31:25 INFO - 'HOME': '/home/cltbld', 12:31:25 INFO - 'LANG': 'en_US.UTF-8', 12:31:25 INFO - 'LANGUAGE': 'en_US:en', 12:31:25 INFO - 'LOGNAME': 'cltbld', 12:31:25 INFO - 'MAIL': '/var/mail/cltbld', 12:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:25 INFO - 'MOZ_NO_REMOTE': '1', 12:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:25 INFO - 'NO_EM_RESTART': '1', 12:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:25 INFO - 'PWD': '/builds/slave/test', 12:31:25 INFO - 'SHELL': '/bin/bash', 12:31:25 INFO - 'SHLVL': '1', 12:31:25 INFO - 'TERM': 'linux', 12:31:25 INFO - 'TMOUT': '86400', 12:31:25 INFO - 'USER': 'cltbld', 12:31:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:25 INFO - '_': '/tools/buildbot/bin/python'} 12:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:25 INFO - Downloading/unpacking flake8 12:31:25 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 12:31:25 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 12:31:25 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 12:31:25 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 12:31:25 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 12:31:25 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 12:31:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:31:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:31:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 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 12:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:31:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:27 INFO - no previously-included directories found matching 'docs/_build' 12:31:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:31:28 INFO - Running setup.py install for pep8 12:31:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:28 INFO - no previously-included directories found matching 'docs/_build' 12:31:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:31:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:31:28 INFO - Cleaning up... 12:31:28 INFO - Return code: 0 12:31:28 INFO - Running post-action listener: _resource_record_post_action 12:31:28 INFO - Running post-action listener: _start_resource_monitoring 12:31:28 INFO - Starting resource monitoring. 12:31:28 INFO - ##### 12:31:28 INFO - ##### Finished create-virtualenv step (success) 12:31:28 INFO - ##### 12:31:28 INFO - ##### 12:31:28 INFO - ##### Running install step. 12:31:28 INFO - ##### 12:31:28 INFO - Running pre-action listener: _resource_record_pre_action 12:31:28 INFO - Running main action method: install 12:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:28 INFO - Reading from file tmpfile_stdout 12:31:28 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:31:28 INFO - Reading from file tmpfile_stdout 12:31:28 INFO - Output received: 12:31:28 INFO - Usage: mozinstall [options] installer 12:31:28 INFO - Options: 12:31:28 INFO - -h, --help show this help message and exit 12:31:28 INFO - -d DEST, --destination=DEST 12:31:28 INFO - Directory to install application into. [default: 12:31:28 INFO - "/builds/slave/test"] 12:31:28 INFO - --app=APP Application being installed. [default: firefox] 12:31:28 INFO - mkdir: /builds/slave/test/build/application 12:31:28 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'] 12:31:28 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 12:31:45 INFO - Reading from file tmpfile_stdout 12:31:45 INFO - Output received: 12:31:45 INFO - /builds/slave/test/build/application/firefox/firefox 12:31:45 INFO - Running post-action listener: _resource_record_post_action 12:31:45 INFO - ##### 12:31:45 INFO - ##### Finished install step (success) 12:31:45 INFO - ##### 12:31:45 INFO - ##### 12:31:45 INFO - ##### Running run-tests step. 12:31:45 INFO - ##### 12:31:45 INFO - Running pre-action listener: _resource_record_pre_action 12:31:45 INFO - Running main action method: run_tests 12:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:31:45 INFO - Python 2.7.3 12:31:45 INFO - Return code: 0 12:31:45 INFO - grabbing minidump binary from tooltool 12:31:45 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')]} 12:31:45 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 0x19f69c0>, '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 0x19f78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:31:45 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 12:31:45 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 12:31:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:31:45 INFO - Return code: 0 12:31:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:31:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:31:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:31:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:31:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:31:46 INFO - Return code: 0 12:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 12:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 12:31:46 INFO - Using env: {'DISPLAY': ':0', 12:31:46 INFO - 'HOME': '/home/cltbld', 12:31:46 INFO - 'LANG': 'en_US.UTF-8', 12:31:46 INFO - 'LANGUAGE': 'en_US:en', 12:31:46 INFO - 'LOGNAME': 'cltbld', 12:31:46 INFO - 'MAIL': '/var/mail/cltbld', 12:31:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:31:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:46 INFO - 'MOZ_NO_REMOTE': '1', 12:31:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:46 INFO - 'NO_EM_RESTART': '1', 12:31:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:46 INFO - 'PWD': '/builds/slave/test', 12:31:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:31:46 INFO - 'SHELL': '/bin/bash', 12:31:46 INFO - 'SHLVL': '1', 12:31:46 INFO - 'TERM': 'linux', 12:31:46 INFO - 'TMOUT': '86400', 12:31:46 INFO - 'USER': 'cltbld', 12:31:46 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224', 12:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:46 INFO - '_': '/tools/buildbot/bin/python'} 12:31:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 12:31:46 INFO - mozversion application_buildid: 20160510053023 12:31:46 INFO - mozversion application_changeset: 2f9351bae69d056e4615d21dda6bf42fec5d16b7 12:31:46 INFO - mozversion application_display_name: Nightly 12:31:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:31:46 INFO - mozversion application_name: Firefox 12:31:46 INFO - mozversion application_remotingname: firefox 12:31:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:31:46 INFO - mozversion application_vendor: Mozilla 12:31:46 INFO - mozversion application_version: 49.0a1 12:31:46 INFO - mozversion platform_buildid: 20160510053023 12:31:46 INFO - mozversion platform_changeset: 2f9351bae69d056e4615d21dda6bf42fec5d16b7 12:31:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:31:46 INFO - mozversion platform_version: 49.0a1 12:31:46 INFO - using testdate: 1462908706 12:31:46 INFO - actual date: 1462908706 12:31:46 INFO - starting webserver on 'localhost:52611' 12:31:46 INFO - SUITE-START | Running 2 tests 12:31:46 INFO - TEST-START | dromaeo_css 12:31:46 INFO - operating with platform_type : linux_ 12:31:46 INFO - Initialising browser for dromaeo_css test... 12:31:46 INFO - TEST-INFO | started process 29152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqgA9G/profile http://localhost:52611/getInfo.html) 12:31:50 INFO - PROCESS | 29152 | __metrics Screen width/height:1600/1200 12:31:50 INFO - PROCESS | 29152 | colorDepth:24 12:31:50 INFO - PROCESS | 29152 | Browser inner width/height: 1024/697 12:31:50 INFO - PROCESS | 29152 | __metrics 12:31:51 ERROR - PROCESS | 29152 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:31:52 INFO - TEST-INFO | 29152: exit 0 12:31:52 INFO - Browser initialized. 12:31:52 INFO - Running cycle 1/1 for dromaeo_css test... 12:31:52 INFO - TEST-INFO | started process 29233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqgA9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:04 INFO - PROCESS | 29233 | RSS: Main: 151732224 12:32:04 INFO - PROCESS | 29233 | 12:32:55 INFO - PROCESS | 29233 | 1462908775345 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] 12:35:03 INFO - PROCESS | 29233 | Cycle 1(1): loaded http://localhost:52611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52611/tests/dromaeo/cssquery-ext.html) 12:35:04 INFO - PROCESS | 29233 | RSS: Main: 247779328 12:35:04 INFO - PROCESS | 29233 | 12:38:06 INFO - PROCESS | 29233 | Cycle 1(1): loaded http://localhost:52611/tests/dromaeo/cssquery-ext.html (next: http://localhost:52611/tests/dromaeo/cssquery-jquery.html) 12:38:07 INFO - PROCESS | 29233 | RSS: Main: 235696128 12:38:07 INFO - PROCESS | 29233 | 12:41:09 INFO - PROCESS | 29233 | Cycle 1(1): loaded http://localhost:52611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52611/tests/dromaeo/cssquery-mootools.html) 12:41:09 INFO - PROCESS | 29233 | RSS: Main: 233705472 12:41:09 INFO - PROCESS | 29233 | 12:44:11 INFO - PROCESS | 29233 | Cycle 1(1): loaded http://localhost:52611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52611/tests/dromaeo/cssquery-prototype.html) 12:44:12 INFO - PROCESS | 29233 | RSS: Main: 233902080 12:44:12 INFO - PROCESS | 29233 | 12:47:14 INFO - PROCESS | 29233 | Cycle 1(1): loaded http://localhost:52611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52611/tests/dromaeo/cssquery-yui.html) 12:47:15 INFO - PROCESS | 29233 | RSS: Main: 224190464 12:47:15 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | Cycle 1(1): loaded http://localhost:52611/tests/dromaeo/cssquery-yui.html (next: http://localhost:52611/tests/dromaeo/cssquery-dojo.html) 12:50:18 INFO - PROCESS | 29233 | RSS: Main: 308961280 12:50:18 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | __start_tp_report 12:50:18 INFO - PROCESS | 29233 | _x_x_mozilla_page_load 12:50:18 INFO - PROCESS | 29233 | _x_x_mozilla_page_load_details 12:50:18 INFO - PROCESS | 29233 | |i|pagename|runs| 12:50:18 INFO - PROCESS | 29233 | |0;dojo.html;3135.451296023196;3142.277276226468;3168.746500279977;3178.2054486378406;3201.63181234158;5280.4983526564965;5286.127788914824;5370.248165256867;5391.622586418952;5402.081646120159;5289.365276166865;5299.417064122943;5350.839474815752;5437.918431223535;5446.319210098738;4747.382840230774;4840.709557426548;4848.127337079324;4848.345473361086;4985.152524070899;4908.533689299528;4926.729029903354;4957.281194226835;4971.6271279654175;4975.4527002029745;4759.690620109682;4805.543473370024;4836.854894353175;4842.1042107210105;4845.030993801254;4823.372961515016;4850.684705494167;4905.092557876804;4920.926186107211;4937.456879743226;4767;4858.125537403266;4858.78135483904;4882.194437917739;4904.092742842586;5183.222516622499;5264.368275806928;5267.710275934822;5343.225232341289;5363.302770639831;5670.716464176775;5715.685637289947;5716.742746576414;5742.167385729088;5765.365809760923;5584.441555844423;5652.773889044433;5760.308762948473;5770.394108618577;5822.650640961556;5337.386200586943;5376.166694162411;5423.755930983115;5424.864378390533;5432.7555260013;5917.852053698692;5928.851778705481;5929.436703513159;5930.169776231331;5930.22907022093;5501.092319767274;5563.276774019432;5581.916271255853;5682.971585142048;5694.572907031989;5778.711064446845;5782.277215348082;5790.507806836382;5800.1299805029585;5825.912611310834;5719.142128680648;5734.913976290359;5737.340205876378;5738.081906894877;5740.3685594585395;5613.747381367848;5640.041192997201;5665.3201615806365;5681.17622944679;5729.627574207663;4319.352097185384;4352.586504282088;4356.302991521341;4360.106178233455;4390.890227744332;3878.1468077023574;3891.299566078133;3899.9610003900166;3928.7249892507252;3945.3884647879627;5271.42014378418;5334.813281535127;5370.946290537123;5376.731163441812;5379.515843574097;5702.572307076985;5715.857103572361;5722.599418040781;5724.942750572441;5730.627509211888;5411.621186516984;5422.213779002102;5427.348718153847;5429.945700543023;5472.042392581362;4850.490698476609;4877.658563900563;4881.877953051131;4903.779329930162;4970.478099799541;5851.853703657443;5872.970635146797;5888.941110588839;5889.676067816225;5923.08192230205;5717.2853393325;5718.599698021098;5726.79956201531;5729.885402292014;5751.654900705971;5689.8008569701515;5782.2483077199695;5861.120831875252;5877;5897.498712609477;5584.86037849057;5619.719014049199;5622.775088996558;5626.5780066496;5626.718664066862;5604.775808967759;5722.284714410699;5730.1977723119635;5734.254546908875;5734.569907257056;5538.280023597068;5597.272354593877;5597.80407685729;5621.353544342453;5624.550035997028;5595.35653399848;5632.352279487911;5636.85907852307;5646.153077038477;5650.717464126859;5328.8401347959625;5396.811111611075;5508.586855985737;5514;5517.917231241615;5568.109102543735;5668.178114173505;5669.4047125051275;5670.036093863971;5671.376148623731;5477.4248703887115;5488.451154884479;5490.478404551562;5491.478309560585;5530.557555395479 12:50:18 INFO - PROCESS | 29233 | |1;ext.html;643.9935600643993;654.5189285874881;660.1418156396685;672.5863593889757;681.543365944817;41971;43456;43486.782566087204;47271.29093063598;47274.763626181906;43965.7801710991;44068.11863762723;44079.559204407946;44124;44129.7793511032;8702.434341767797;8921.643134274622;8925.241354484877;8927.241184499293;8930.464172149692;8768.69309574165;8829.293656507496;8849.823003539957;8856.911430885673;8860.734177974638;8868.467891926473;8916.15296546827;8923.241524470428;8923.910760892373;8925.41984770991;8863.157999989991;8886.511241881693;8893.199612034949;8893.599788009555;8899.95550022249;8697.304215662733;8706.042335343107;8706.521141337224;8734;8787.472751634858;40470;40833.59166408327;40937.38593921094;40955.795221023705;41022.589774102176;3588.6231945645854;4055.41196526502;4133.524644665842;4146.626803587661;4242.936355954663;32256;32487.51268730971;33337.16657083568;34702.13244668878;35582.46626300608;4282.443282373302;4291.4850217973735;4304.74171549708;4338.240807858612;4339.240632889263;311724;313486;316680;317197;317538.4123079393;61379.386206137366;62099.37900620936;62141.689291554154;62144.68927655333;62201.68899155475;55713.442865570825;56749.43250567524;56773;62201;62238;14434.783478247624;15184.924075379773;15330.386784528717;15346.386144554093;15347.462838800588;11934.462949167308;12012.63962081139;12021.278723276631;12027.939860300818;12031.759364812655;17348.3060677574;18963.62072758537;19027.14377853;19220.519487012658;19484.51288717765;6840.281770414134;6925.217443434688;6952.513324067267;7138.9324568677675;7198.604076775723;997.9750506237257;1023.5291765787821;1152.2913408253864;1152.8501294831617;1194.964151075469;31205.531917021264;31807.681923180935;31826.522602160985;31855.52216716751;32390.514142287884;1177.240679761549;1178.9646310610694;1189.3755778216332;1209.7096696792707;1211.5638370186725;16789.24448399825;16850.494485165465;17067.743983840253;17106.828931710523;17439;142644.2867785675;142778;142979;143077.28461357835;143701;54928;56011.43988560062;56033.43966560364;56047.71976140175;56102.43897561054;1260.87391260875;1320.953766618183;1332.0675527131048;1376.7865980772797;1391.7425276323913;25990.87004565041;33954.66045339515;33995.15012124618;34112.65887341095;34461.31077378388;52842;53495;53496.465035349145;53539.464605353445;53642.19536707031;316296;323572;323751;323846;323930;24712.752872471046;25351;28140.155795326173;28546;44180.55819441893;44240.33639495474;45002.77498612617;47947.280790788864;48600.270995934385;48638.5136148634;38300.6169938297;40869.59130408658;40949;41141.79429102835;41464.34142634261;41617.79191104146;41790.373144403464;41849.372259415526;41905.92364107126;42019.7899010503;40356.394654079624;40389.79805100956;41898.79050604728;42017.369739454545;42040.78979605083;35328;36015.45976810298;36833.26333473262;37123;37224.81387593153;27073.45853082888;27699.58450623202;28193;28456.430871382872;28491.572626411034 12:50:18 INFO - PROCESS | 29233 | |2;jquery.html;387.38019169329067;396.7302234480553;406.38838547985296;406.5406091117037;412.8204231159448;14023.719525609507;16748.246328915197;17589.560260993483;19446.708299375503;19472.41582752518;14768.113913165218;17001.82998170018;17860;18183.636327273445;18950;5537.778488860451;5668.971655141719;5712.314522257335;5713.257276554042;5738.3974682658345;4122.917541649165;5486.780528778844;5902.468777809996;6299.559030867841;6317;6256.436920677138;6286.779962701306;6328.462080723144;6331.968340158316;6364.840878978016;6204.9069263960855;6352.36476352361;6366.076918846765;6367.5861069030825;6370.140031095789;5544.780148367393;5568.638038527482;5609;5628.465295796893;5700.372958974551;22468.550628987494;23097.422564435856;23125.306240812803;23169.768302317098;23566.646500302508;2166.7616562178305;2272.125231785758;2677.9330516737236;2797.2307615405925;3062.5406189071596;14616.780748288784;15139.167345795977;15338.233088345649;15555.455559055492;16235.431759888465;2020.5150763816578;2026.9189232430685;2063.123172651617;2070.596233734422;2137.1130980643015;58706.706466467396;94270.52864735702;96634.51682741611;97335;97368.51315743376;17307.653846922993;17436.389726359517;17721.29114835392;17877.642447151244;18129.728054079198;31872.362552748815;31987.840060799546;32002.959718826674;32169;32269.35461290808;9273.211776999031;9382.765430864147;9485.573149208301;9566.091221333962;9571;6532.738690452424;7522.924770752332;7841.059072911173;7847.254510821463;8045.758627241075;8416;8636.55656255464;9031.954840225757;9038.457692538468;9072.274218062672;3253.772235943461;3285.6385797562248;3401.727861771052;3426.901576314888;3435.7251419886347;916.4318122763929;997.9550920208463;1001.4992503748126;1010.8584798128268;1012.6961911426542;18229.7265541017;18421.723674144898;18709.064546772606;18712.157952892154;19149.425517234504;1000.7097941597001;1003.8217068960373;1049.4385503755454;1050.4905121016302;1055.1453322808395;10067.597296108073;10139.138173255209;10585;10590.57637694499;10693.946530267454;488513;506716;507700;509144;518596;57169.42830571724;71198;84871.57564212139;93966;94407;1062.5484169228048;1067.588978243382;1082.7455547946226;1086.8587083679072;1095.6359332631084;16596.336146554004;16760.24578893977;16875.7468637973;17047.23287452043;17334.219960101575;38635.22729545337;39682.40476392914;39863.60136398599;40225.39661905015;41410.37884431676;55406.44593554013;55543.722281388335;56107.15839262333;56149.71925140348;56480;6414.871702566016;8356.749297521084;8459.365547583833;8481.40630155883;8719.65121395137;12719.74560508766;13039.869601303866;13080.345982700637;13116.868831311565;13117.540886068942;11244.606438774603;11270.211085224284;11522.942385288019;11657.125715571197;11709.648710538697;11435.428228588371;11455.942720286344;11504.712382190512;11585.131115166228;11660.358680272328;6276.748930042747;7952.886595876697;11723.237989530653;11840.407979600814;11891.881081189078;8175.3868459866935;8196.467229630054;8197.71308004217;8302;8442.451240669337;8446.915530844613;10215.080642742189;11449.313041217554;11624.476898539755;12017.759644807229 12:50:18 INFO - PROCESS | 29233 | |3;mootools.html;1386.8613138686126;1540.684159747252;1569.1761825041854;1748.8426041656257;1886.5000774794682;8327.541985190812;8745.956270218649;8750.6937257196;8942.955285223581;8950.820983580325;8619.65521379144;8791.912080879189;8793.95603021984;8795.560221988891;8801.735947921572;2098.0139334512833;2362.2558893948435;2413.927582172533;2433.3429973907037;2445.058652418814;2413.9275821725378;2421.757824217582;2424.0244200976235;2424.49085692004;2426.284246147382;2345.5308938212343;2400.375902265415;2401.5076909233653;2402.1952645863657;2405.855648661086;2086.926957556486;2324.8140148788143;2402.3153401280724;2408.891599877992;2424;2328.685627440291;2329.4176455886027;2331.195737470587;2331.6152834782242;2375.6792832967676;8822.2060014599;8848.026717061119;8870.06864279248;8881.511516866569;8882.555872206363;5180.611454140954;5239.528442440199;5242.711650859202;5281.419043905167;5290.470952904679;3387.220939183977;3417.726581873444;3476.8435420406145;3536;3543.167355671415;1123.9269447485888;1165.4871856383165;1202.1404695642657;1225.3873063468266;1239.5413696932194;11850.525978960832;11858.703532411673;11864.288142711464;11887.167898247126;11891.345975971319;4631.58315751584;4650.255959046536;4736.478987311393;4764.6664733469015;4790.233562629963;9848.852267215998;9858.162056225157;9860.605575777032;9881.160101391319;9886;4865.148598995162;5179.430262671103;5284.07528682479;5291.3385826771655;5297.735113244323;4829.782659780319;4949.158643030693;4971.328870602495;5022.146235140035;5057.418396884332;4093.7339072960162;4104.076582768913;4148.605882441163;4150.91698166035;4194.706370554032;1309.3780454284329;1339.4575197045212;1341.2958196946681;1347.036868638928;1363.8977076719286;949.4540639132526;1048.2400259811727;1051.4690081508943;1055.8310670292717;1064.1912146768511;6246.312905580474;6324.494040476751;6371.713272902731;6387.904181437282;6502.593379051022;460.86174147755537;464.1459714126024;465.9836905708284;995.2635050062902;1077.1221454514703;4248.511421186541;4301.677374196947;4319.97840010798;4320.719153255029;4321.481422229353;11014.834777478345;11324.15068869838;11407;11530.250533715282;11547.364894930859;11194.888051119548;11384.146189035855;11432.314061156358;11449.885501145049;11455.369954652408;7934.246246606564;8289.212524810133;8316.708915187939;8394.24451799341;8440.649496080598;6217.564770466205;6282.780102696383;6306.274778400542;6411.71147298382;6440.033994900615;9606.567704453177;10082.890882002826;10149.898501014895;10195;10197.694069177936;9802.460864652227;10195.23535734808;10217.33587316822;10313.845292320771;10414.791704165722;8048.557329346942;8125.918740812753;8181.140980196994;8208.712695055645;8214.424990250625;8596.097409771884;8612.870806937775;8653.17794809492;8664.176903194186;8690.174433428814;7878.763637090897;8053.798655033671;8097.635606397608;8133.511989280662;8237.876431853407;7740.1098873628;7877.487963282369;7892;7912.84174316522;7917.168697286702;7185.317394847481;7217.819554511179;7260.4554658401885;7336.229695881855;7365;5513.972430137824;5538.252335934597;5548.500634942875;5600.299962504687;5711.485966263056;5398.244245805512;5398.2712333836;5414.648047876875;5425.077736784677;5434.184872269033 12:50:18 INFO - PROCESS | 29233 | |4;prototype.html;326.6553785756027;340.848322496489;345.69751467465966;351.50437882585544;359.0914985087729;5249.13389290767;5310.9378124375135;5320.574354051676;5378.462153784624;5381.408045115034;5268.631195816294;5268.683878967265;5287.180487024508;5307.52232299093;5308.23030660554;3746.0260332313524;3946.2107578484274;4075.3071977763852;4126.752394856303;4208.705390622657;4151.14901445203;4168.7081904266715;4170.624643782059;4176.68674849386;4188.874333769976;4150.260827853617;4161.708680392374;4161.895952601194;4167.916641667165;4176.624103830654;3968.8610898618554;4013.5585085640555;4133.7106402551835;4149.356849688304;4167.458230430055;3671.541057367829;3703.907402314937;3705.277470893177;3707.888763337104;3722.5160729105314;5071.492850714936;5077.593792496591;5084.923726144111;5085.330201644167;5096.719680417576;4498.527654596253;4727.45634252062;4749;4757.238841785298;4758.381410416624;5434.505510984472;5450.400455949843;5467.5625949923915;5490.450954904518;5529.889402211933;3965.7620542767236;3967.305721498726;3970.1935619293154;3975.6421922026866;3985.7608543487486;5442.455754424565;5489.4236105209175;5575.275214222166;5683.318001839764;5703.201551782754;3918.1575961168487;3950.5654378018394;3955.20895820837;4024.557298697141;4052.7163098583405;4069.450624165759;4079.3065178919655;4079.8168531125643;4088.6115818997146;4107.589241075869;4560.293154561048;4639.350490931272;4650.441946966385;4672.602828759594;4673.158831410311;5424.62027658068;5513.7794488220825;5517.668939863541;5519.9448005520235;5541.6120871539415;1383.667919699265;1418.4255376572505;1422.50923431416;1423.3025817349424;1425.365712258056;884.823035392924;897.7396554998977;910.8477775613853;931.4457897550947;933.2906990687127;4633.096546173464;4755.714657120584;4769.35613692154;4776.928346074812;4793.825512749329;4970.577500912391;4995.900081998412;5009.6223538526465;5041.445780724581;5048.894929618332;4687.95312046882;4713.882152946204;4757.857264282077;4788.545088216614;4892.437369702529;2950.7459329784756;3012.472817256971;3014.8794048238265;3016.3364059906785;3033.9393212136074;5804.216430781875;5824.776796872619;5838.737256823369;5850.882982340329;5859.44335288147;5583.35791383996;5765.549641402471;5773.913391299134;5780.393058728857;5817.749183925392;5825.38833422493;5866.530677545786;5885.529157667376;5919.792807251725;5944.435278648608;5386.114859799039;5763.4524720153195;5768.192453056659;5771.441710738161;5779.393163717918;5657.349404818334;5699.458551437607;5700.201971723879;5730.856728581819;5735.54115670737;5660.716964151694;5744.741486633196;5888;5899.38056504078;5960.940390596039;3998.680105591604;4049.453323801249;4054.2094291612852;4060.39094135882;4071.5724848891623;5629.493345598916;5663.32040155184;5711.057675483498;5745.3105627324985;5747.626404283708;5330.813421530228;5560.914657003624;5579.8884022320135;5583.581231407579;5597;5523.558115350682;5532.5020748132865;5545.445455454423;5563.415841336763;5587.888242235052;5278;5435.619506634498;5474.972625136849;5481.945180548143;5481.972590137024;5576.1356989666665;5579.358373786904;5581.804636837691;5588.497035266845;5600.411956744483;5438.199327346499;5456.863578410572;5462.617616766947;5464.398916119144;5489.1217405214975 12:50:18 INFO - PROCESS | 29233 | |5;yui.html;706.1949377709416;803.7186984555407;810.9432339736219;862.2412277196066;867.3754896474544;13115.213087214774;13432.865671343283;13447.394867230974;13555.118917270383;13607.115537490068;13496;13515.59453216405;13546.796798048012;13553.728925421485;13575.660608484794;683.5795985468926;800.8398320335926;824.5588610093586;831.8876951611516;840.315143158327;811.5414790643297;818.3739439328918;824.5959479854888;824.6454024769347;825.1377310710292;872.7818045488627;876.2902049340055;876.776422012386;877.398981697536;877.5831480046959;717.9605121718304;842.8819965204876;869.0527325215483;873.1007062725403;874.7332063720563;633.6546582112713;634.2325785799188;637.5823835387829;640.2029473305718;640.8141638924707;13151.86848131516;13173.407196676077;13185.60443186706;13189.86810131896;13208.405621747044;12807.359632018362;13254.427311792806;13258.933705331508;13276.933615331862;13441.588633193473;10805.243632945698;11078.556857725682;11218.439078046065;12049.57826476078;12425.937870310681;4502.89989531602;4506.391637128979;4560.247559152735;4594.33382159585;4698.459677137139;55335.16997245044;56329.71835140839;57511;57737.42262577362;57770;9990;10033.849492257623;10920.836187457195;11243.60647377338;11262.662120136409;19079.713804292947;19138.56460765448;19230.03849807532;19339.80660193408;19350.709739353922;8072.475289106189;8109.594520273963;8136.593170341577;8380.078191398941;8439.704610338731;4618.722876627413;4677.672562920631;4784.712917224978;4835.758212089381;4844;3483.9477407838904;3488.66857648523;3576.803275819855;3586.049696830342;3681.4293784463453;541.5667466027163;642.8746394453037;700.0549258500982;701.9017337572744;702.2100137345486;618.8886000519859;726.2374506767873;732.8933310700774;793.8848866914265;795.6061749434067;9915.454649994319;10002.299839011199;10051;10260.538275777608;10264;665.6971078159426;666.6067020457953;725.8149171961117;742.5878637356211;755.9773206803804;4540.682152249311;4540.8637740867825;4703.858884233478;4856.587190088882;4881.804727810848;62808.37191628117;63277.355877633105;64802.67598662071;65291;66037;57622;57904.71047644819;58434;59192.70403647954;59601.83402473182;52600.21099683508;52775.73612131915;53482.732586337595;53629;54368.18447723287;9031.729048128567;9172.908270917205;9276.489793061177;9387.483688397204;9509.952450237704;31644;32047.35905281928;32060.6793932067;32162.35675286528;33256.33487330288;42260.154796904506;42459;42669.57330426656;43173.352399714655;43560.128797424506;12491.687707807014;12586.87413125857;12710.906092925505;12765.361731913554;12792.488300467878;13560.186388816703;14066.156030638194;14332.928335358256;14451.349689264218;14960.251987400368;13075;13150.473981040652;13243.735125297633;13250.867491324963;13677.31613419345;13016.219026858418;13063;13834.446622135001;13864.653383665489;14149.08030977983;13117.672058198621;13394.129381590166;13478.32608369558;13590.45638174462;13895.374708137955;10524;10594.947025264824;10761.838572421264;10813.837792433276;11118.944405277922;10783.6225732099;10894.891051089704;11028.172887033345;11055.834162487408;11059.944700276446 12:50:18 INFO - PROCESS | 29233 | __end_tp_report 12:50:18 INFO - PROCESS | 29233 | __start_cc_report 12:50:18 INFO - PROCESS | 29233 | _x_x_mozilla_cycle_collect,837 12:50:18 INFO - PROCESS | 29233 | __end_cc_report 12:50:18 INFO - PROCESS | 29233 | __startTimestamp1462909818482__endTimestamp 12:50:18 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | ------- Summary: start ------- 12:50:18 INFO - PROCESS | 29233 | Number of tests: 6 12:50:18 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | [#0] dojo.html Cycles:165 Average:5313.09 Median:5508.59 stddev:594.52 (10.8%) stddev-sans-first:571.27 12:50:18 INFO - PROCESS | 29233 | Values: 3135.5 3142.3 3168.7 3178.2 3201.6 5280.5 5286.1 5370.2 5391.6 5402.1 5289.4 5299.4 5350.8 5437.9 5446.3 4747.4 4840.7 4848.1 4848.3 4985.2 4908.5 4926.7 4957.3 4971.6 4975.5 4759.7 4805.5 4836.9 4842.1 4845.0 4823.4 4850.7 4905.1 4920.9 4937.5 4767.0 4858.1 4858.8 4882.2 4904.1 5183.2 5264.4 5267.7 5343.2 5363.3 5670.7 5715.7 5716.7 5742.2 5765.4 5584.4 5652.8 5760.3 5770.4 5822.7 5337.4 5376.2 5423.8 5424.9 5432.8 5917.9 5928.9 5929.4 5930.2 5930.2 5501.1 5563.3 5581.9 5683.0 5694.6 5778.7 5782.3 5790.5 5800.1 5825.9 5719.1 5734.9 5737.3 5738.1 5740.4 5613.7 5640.0 5665.3 5681.2 5729.6 4319.4 4352.6 4356.3 4360.1 4390.9 3878.1 3891.3 3900.0 3928.7 3945.4 5271.4 5334.8 5370.9 5376.7 5379.5 5702.6 5715.9 5722.6 5724.9 5730.6 5411.6 5422.2 5427.3 5429.9 5472.0 4850.5 4877.7 4881.9 4903.8 4970.5 5851.9 5873.0 5888.9 5889.7 5923.1 5717.3 5718.6 5726.8 5729.9 5751.7 5689.8 5782.2 5861.1 5877.0 5897.5 5584.9 5619.7 5622.8 5626.6 5626.7 5604.8 5722.3 5730.2 5734.3 5734.6 5538.3 5597.3 5597.8 5621.4 5624.6 5595.4 5632.4 5636.9 5646.2 5650.7 5328.8 5396.8 5508.6 5514.0 5517.9 5568.1 5668.2 5669.4 5670.0 5671.4 5477.4 5488.5 5490.5 5491.5 5530.6 12:50:18 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | [#1] ext.html Cycles:180 Average:45287.95 Median:22637.66 stddev:71674.65 (316.6%) stddev-sans-first:71797.33 12:50:18 INFO - PROCESS | 29233 | Values: 644.0 654.5 660.1 672.6 681.5 41971.0 43456.0 43486.8 47271.3 47274.8 43965.8 44068.1 44079.6 44124.0 44129.8 8702.4 8921.6 8925.2 8927.2 8930.5 8768.7 8829.3 8849.8 8856.9 8860.7 8868.5 8916.2 8923.2 8923.9 8925.4 8863.2 8886.5 8893.2 8893.6 8900.0 8697.3 8706.0 8706.5 8734.0 8787.5 40470.0 40833.6 40937.4 40955.8 41022.6 3588.6 4055.4 4133.5 4146.6 4242.9 32256.0 32487.5 33337.2 34702.1 35582.5 4282.4 4291.5 4304.7 4338.2 4339.2 311724.0 313486.0 316680.0 317197.0 317538.4 61379.4 62099.4 62141.7 62144.7 62201.7 55713.4 56749.4 56773.0 62201.0 62238.0 14434.8 15184.9 15330.4 15346.4 15347.5 11934.5 12012.6 12021.3 12027.9 12031.8 17348.3 18963.6 19027.1 19220.5 19484.5 6840.3 6925.2 6952.5 7138.9 7198.6 998.0 1023.5 1152.3 1152.9 1195.0 31205.5 31807.7 31826.5 31855.5 32390.5 1177.2 1179.0 1189.4 1209.7 1211.6 16789.2 16850.5 17067.7 17106.8 17439.0 142644.3 142778.0 142979.0 143077.3 143701.0 54928.0 56011.4 56033.4 56047.7 56102.4 1260.9 1321.0 1332.1 1376.8 1391.7 25990.9 33954.7 33995.2 34112.7 34461.3 52842.0 53495.0 53496.5 53539.5 53642.2 316296.0 323572.0 323751.0 323846.0 323930.0 24712.8 25351.0 28140.2 28546.0 44180.6 44240.3 45002.8 47947.3 48600.3 48638.5 38300.6 40869.6 40949.0 41141.8 41464.3 41617.8 41790.4 41849.4 41905.9 42019.8 40356.4 40389.8 41898.8 42017.4 42040.8 35328.0 36015.5 36833.3 37123.0 37224.8 27073.5 27699.6 28193.0 28456.4 28491.6 12:50:18 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | [#2] jquery.html Cycles:180 Average:30006.09 Median:3269.71 stddev:83238.43 (2545.7%) stddev-sans-first:83442.22 12:50:18 INFO - PROCESS | 29233 | Values: 387.4 396.7 406.4 406.5 412.8 14023.7 16748.2 17589.6 19446.7 19472.4 14768.1 17001.8 17860.0 18183.6 18950.0 5537.8 5669.0 5712.3 5713.3 5738.4 4122.9 5486.8 5902.5 6299.6 6317.0 6256.4 6286.8 6328.5 6332.0 6364.8 6204.9 6352.4 6366.1 6367.6 6370.1 5544.8 5568.6 5609.0 5628.5 5700.4 22468.6 23097.4 23125.3 23169.8 23566.6 2166.8 2272.1 2677.9 2797.2 3062.5 14616.8 15139.2 15338.2 15555.5 16235.4 2020.5 2026.9 2063.1 2070.6 2137.1 58706.7 94270.5 96634.5 97335.0 97368.5 17307.7 17436.4 17721.3 17877.6 18129.7 31872.4 31987.8 32003.0 32169.0 32269.4 9273.2 9382.8 9485.6 9566.1 9571.0 6532.7 7522.9 7841.1 7847.3 8045.8 8416.0 8636.6 9032.0 9038.5 9072.3 3253.8 3285.6 3401.7 3426.9 3435.7 916.4 998.0 1001.5 1010.9 1012.7 18229.7 18421.7 18709.1 18712.2 19149.4 1000.7 1003.8 1049.4 1050.5 1055.1 10067.6 10139.1 10585.0 10590.6 10693.9 488513.0 506716.0 507700.0 509144.0 518596.0 57169.4 71198.0 84871.6 93966.0 94407.0 1062.5 1067.6 1082.7 1086.9 1095.6 16596.3 16760.2 16875.7 17047.2 17334.2 38635.2 39682.4 39863.6 40225.4 41410.4 55406.4 55543.7 56107.2 56149.7 56480.0 6414.9 8356.7 8459.4 8481.4 8719.7 12719.7 13039.9 13080.3 13116.9 13117.5 11244.6 11270.2 11522.9 11657.1 11709.6 11435.4 11455.9 11504.7 11585.1 11660.4 6276.7 7952.9 11723.2 11840.4 11891.9 8175.4 8196.5 8197.7 8302.0 8442.5 8446.9 10215.1 11449.3 11624.5 12017.8 12:50:18 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | [#3] mootools.html Cycles:180 Average:5911.58 Median:4810.01 stddev:3305.36 (68.7%) stddev-sans-first:3297.14 12:50:18 INFO - PROCESS | 29233 | Values: 1386.9 1540.7 1569.2 1748.8 1886.5 8327.5 8746.0 8750.7 8943.0 8950.8 8619.7 8791.9 8794.0 8795.6 8801.7 2098.0 2362.3 2413.9 2433.3 2445.1 2413.9 2421.8 2424.0 2424.5 2426.3 2345.5 2400.4 2401.5 2402.2 2405.9 2086.9 2324.8 2402.3 2408.9 2424.0 2328.7 2329.4 2331.2 2331.6 2375.7 8822.2 8848.0 8870.1 8881.5 8882.6 5180.6 5239.5 5242.7 5281.4 5290.5 3387.2 3417.7 3476.8 3536.0 3543.2 1123.9 1165.5 1202.1 1225.4 1239.5 11850.5 11858.7 11864.3 11887.2 11891.3 4631.6 4650.3 4736.5 4764.7 4790.2 9848.9 9858.2 9860.6 9881.2 9886.0 4865.1 5179.4 5284.1 5291.3 5297.7 4829.8 4949.2 4971.3 5022.1 5057.4 4093.7 4104.1 4148.6 4150.9 4194.7 1309.4 1339.5 1341.3 1347.0 1363.9 949.5 1048.2 1051.5 1055.8 1064.2 6246.3 6324.5 6371.7 6387.9 6502.6 460.9 464.1 466.0 995.3 1077.1 4248.5 4301.7 4320.0 4320.7 4321.5 11014.8 11324.2 11407.0 11530.3 11547.4 11194.9 11384.1 11432.3 11449.9 11455.4 7934.2 8289.2 8316.7 8394.2 8440.6 6217.6 6282.8 6306.3 6411.7 6440.0 9606.6 10082.9 10149.9 10195.0 10197.7 9802.5 10195.2 10217.3 10313.8 10414.8 8048.6 8125.9 8181.1 8208.7 8214.4 8596.1 8612.9 8653.2 8664.2 8690.2 7878.8 8053.8 8097.6 8133.5 8237.9 7740.1 7877.5 7892.0 7912.8 7917.2 7185.3 7217.8 7260.5 7336.2 7365.0 5514.0 5538.3 5548.5 5600.3 5711.5 5398.2 5398.3 5414.6 5425.1 5434.2 12:50:18 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | [#4] prototype.html Cycles:180 Average:4610.62 Median:5258.88 stddev:1352.42 (25.7%) stddev-sans-first:1317.44 12:50:18 INFO - PROCESS | 29233 | Values: 326.7 340.8 345.7 351.5 359.1 5249.1 5310.9 5320.6 5378.5 5381.4 5268.6 5268.7 5287.2 5307.5 5308.2 3746.0 3946.2 4075.3 4126.8 4208.7 4151.1 4168.7 4170.6 4176.7 4188.9 4150.3 4161.7 4161.9 4167.9 4176.6 3968.9 4013.6 4133.7 4149.4 4167.5 3671.5 3703.9 3705.3 3707.9 3722.5 5071.5 5077.6 5084.9 5085.3 5096.7 4498.5 4727.5 4749.0 4757.2 4758.4 5434.5 5450.4 5467.6 5490.5 5529.9 3965.8 3967.3 3970.2 3975.6 3985.8 5442.5 5489.4 5575.3 5683.3 5703.2 3918.2 3950.6 3955.2 4024.6 4052.7 4069.5 4079.3 4079.8 4088.6 4107.6 4560.3 4639.4 4650.4 4672.6 4673.2 5424.6 5513.8 5517.7 5519.9 5541.6 1383.7 1418.4 1422.5 1423.3 1425.4 884.8 897.7 910.8 931.4 933.3 4633.1 4755.7 4769.4 4776.9 4793.8 4970.6 4995.9 5009.6 5041.4 5048.9 4688.0 4713.9 4757.9 4788.5 4892.4 2950.7 3012.5 3014.9 3016.3 3033.9 5804.2 5824.8 5838.7 5850.9 5859.4 5583.4 5765.5 5773.9 5780.4 5817.7 5825.4 5866.5 5885.5 5919.8 5944.4 5386.1 5763.5 5768.2 5771.4 5779.4 5657.3 5699.5 5700.2 5730.9 5735.5 5660.7 5744.7 5888.0 5899.4 5960.9 3998.7 4049.5 4054.2 4060.4 4071.6 5629.5 5663.3 5711.1 5745.3 5747.6 5330.8 5560.9 5579.9 5583.6 5597.0 5523.6 5532.5 5545.4 5563.4 5587.9 5278.0 5435.6 5475.0 5481.9 5482.0 5576.1 5579.4 5581.8 5588.5 5600.4 5438.2 5456.9 5462.6 5464.4 5489.1 12:50:18 INFO - PROCESS | 29233 | 12:50:18 INFO - PROCESS | 29233 | [#5] yui.html Cycles:180 Average:15118.27 Median:4540.77 stddev:17634.36 (388.4%) stddev-sans-first:17650.62 12:50:18 INFO - PROCESS | 29233 | Values: 706.2 803.7 810.9 862.2 867.4 13115.2 13432.9 13447.4 13555.1 13607.1 13496.0 13515.6 13546.8 13553.7 13575.7 683.6 800.8 824.6 831.9 840.3 811.5 818.4 824.6 824.6 825.1 872.8 876.3 876.8 877.4 877.6 718.0 842.9 869.1 873.1 874.7 633.7 634.2 637.6 640.2 640.8 13151.9 13173.4 13185.6 13189.9 13208.4 12807.4 13254.4 13258.9 13276.9 13441.6 10805.2 11078.6 11218.4 12049.6 12425.9 4502.9 4506.4 4560.2 4594.3 4698.5 55335.2 56329.7 57511.0 57737.4 57770.0 9990.0 10033.8 10920.8 11243.6 11262.7 19079.7 19138.6 19230.0 19339.8 19350.7 8072.5 8109.6 8136.6 8380.1 8439.7 4618.7 4677.7 4784.7 4835.8 4844.0 3483.9 3488.7 3576.8 3586.0 3681.4 541.6 642.9 700.1 701.9 702.2 618.9 726.2 732.9 793.9 795.6 9915.5 10002.3 10051.0 10260.5 10264.0 665.7 666.6 725.8 742.6 756.0 4540.7 4540.9 4703.9 4856.6 4881.8 62808.4 63277.4 64802.7 65291.0 66037.0 57622.0 57904.7 58434.0 59192.7 59601.8 52600.2 52775.7 53482.7 53629.0 54368.2 9031.7 9172.9 9276.5 9387.5 9510.0 31644.0 32047.4 32060.7 32162.4 33256.3 42260.2 42459.0 42669.6 43173.4 43560.1 12491.7 12586.9 12710.9 12765.4 12792.5 13560.2 14066.2 14332.9 14451.3 14960.3 13075.0 13150.5 13243.7 13250.9 13677.3 13016.2 13063.0 13834.4 13864.7 14149.1 13117.7 13394.1 13478.3 13590.5 13895.4 10524.0 10594.9 10761.8 10813.8 11118.9 10783.6 10894.9 11028.2 11055.8 11059.9 12:50:18 INFO - PROCESS | 29233 | -------- Summary: end -------- 12:50:18 INFO - PROCESS | 29233 | 12:50:19 INFO - TEST-INFO | 29233: exit 0 12:50:19 INFO - TEST-OK | dromaeo_css | took 1112857ms 12:50:19 INFO - TEST-START | kraken 12:50:19 INFO - operating with platform_type : linux_ 12:50:19 INFO - Initialising browser for kraken test... 12:50:19 INFO - TEST-INFO | started process 29410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgZPIVA/profile http://localhost:52611/getInfo.html) 12:50:23 INFO - PROCESS | 29410 | __metrics Screen width/height:1600/1200 12:50:23 INFO - PROCESS | 29410 | colorDepth:24 12:50:23 INFO - PROCESS | 29410 | Browser inner width/height: 1024/697 12:50:23 INFO - PROCESS | 29410 | __metrics 12:50:24 ERROR - PROCESS | 29410 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:50:24 INFO - TEST-INFO | 29410: exit 0 12:50:24 INFO - Browser initialized. 12:50:24 INFO - Running cycle 1/1 for kraken test... 12:50:24 INFO - TEST-INFO | started process 29490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgZPIVA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:36 INFO - PROCESS | 29490 | RSS: Main: 152485888 12:50:36 INFO - PROCESS | 29490 | 12:50:39 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52611/tests/kraken/driver.html?testName=audio-beat-detection) 12:50:40 INFO - PROCESS | 29490 | RSS: Main: 207699968 12:50:40 INFO - PROCESS | 29490 | 12:50:42 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52611/tests/kraken/driver.html?testName=audio-dft) 12:50:43 INFO - PROCESS | 29490 | RSS: Main: 198135808 12:50:43 INFO - PROCESS | 29490 | 12:50:46 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52611/tests/kraken/driver.html?testName=audio-fft) 12:50:47 INFO - PROCESS | 29490 | RSS: Main: 264646656 12:50:47 INFO - PROCESS | 29490 | 12:50:49 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52611/tests/kraken/driver.html?testName=audio-oscillator) 12:50:50 INFO - PROCESS | 29490 | RSS: Main: 174485504 12:50:50 INFO - PROCESS | 29490 | 12:50:52 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:50:53 INFO - PROCESS | 29490 | RSS: Main: 178974720 12:50:53 INFO - PROCESS | 29490 | 12:50:56 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52611/tests/kraken/driver.html?testName=imaging-darkroom) 12:50:56 INFO - PROCESS | 29490 | RSS: Main: 214028288 12:50:56 INFO - PROCESS | 29490 | 12:51:00 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52611/tests/kraken/driver.html?testName=imaging-desaturate) 12:51:01 INFO - PROCESS | 29490 | RSS: Main: 212148224 12:51:01 INFO - PROCESS | 29490 | 12:51:03 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52611/tests/kraken/driver.html?testName=json-parse-financial) 12:51:04 INFO - PROCESS | 29490 | RSS: Main: 213377024 12:51:04 INFO - PROCESS | 29490 | 12:51:06 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:51:06 INFO - PROCESS | 29490 | RSS: Main: 203218944 12:51:06 INFO - PROCESS | 29490 | 12:51:08 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52611/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:51:09 INFO - PROCESS | 29490 | RSS: Main: 206794752 12:51:09 INFO - PROCESS | 29490 | 12:51:11 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:51:12 INFO - PROCESS | 29490 | RSS: Main: 214573056 12:51:12 INFO - PROCESS | 29490 | 12:51:14 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:51:15 INFO - PROCESS | 29490 | RSS: Main: 222244864 12:51:15 INFO - PROCESS | 29490 | 12:51:18 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:51:18 INFO - PROCESS | 29490 | RSS: Main: 217567232 12:51:18 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | Cycle 1(1): loaded http://localhost:52611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52611/tests/kraken/driver.html?testName=ai-astar) 12:51:20 INFO - PROCESS | 29490 | RSS: Main: 263417856 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | __start_tp_report 12:51:20 INFO - PROCESS | 29490 | _x_x_mozilla_page_load 12:51:20 INFO - PROCESS | 29490 | _x_x_mozilla_page_load_details 12:51:20 INFO - PROCESS | 29490 | |i|pagename|runs| 12:51:20 INFO - PROCESS | 29490 | |0;ai-astar;110;106;111;111;111;112;113;109;110;109 12:51:20 INFO - PROCESS | 29490 | |1;audio-beat-detection;158;124;155;208;126;162;150;128;185;125 12:51:20 INFO - PROCESS | 29490 | |2;audio-dft;160;161;159;160;159;161;161;162;162;160 12:51:20 INFO - PROCESS | 29490 | |3;audio-fft;75;75;75;145;76;74;75;79;134;76 12:51:20 INFO - PROCESS | 29490 | |4;audio-oscillator;93;91;155;92;91;91;125;92;91;127 12:51:20 INFO - PROCESS | 29490 | |5;imaging-gaussian-blur;117;117;117;116;116;117;116;116;117;117 12:51:20 INFO - PROCESS | 29490 | |6;imaging-darkroom;147;147;147;145;145;146;145;146;147;146 12:51:20 INFO - PROCESS | 29490 | |7;imaging-desaturate;94;97;95;95;95;96;96;95;95;95 12:51:20 INFO - PROCESS | 29490 | |8;json-parse-financial;58;57;59;57;56;57;58;110;55;55 12:51:20 INFO - PROCESS | 29490 | |9;json-stringify-tinderbox;58;59;59;58;59;59;59;59;59;59 12:51:20 INFO - PROCESS | 29490 | |10;stanford-crypto-aes;79;79;92;80;78;79;80;79;84;79 12:51:20 INFO - PROCESS | 29490 | |11;stanford-crypto-ccm;125;126;134;123;122;128;126;123;189;136 12:51:20 INFO - PROCESS | 29490 | |12;stanford-crypto-pbkdf2;167;165;164;163;164;171;169;166;170;163 12:51:20 INFO - PROCESS | 29490 | |13;stanford-crypto-sha256-iterative;69;68;64;65;67;65;63;64;64;68 12:51:20 INFO - PROCESS | 29490 | __end_tp_report 12:51:20 INFO - PROCESS | 29490 | __start_cc_report 12:51:20 INFO - PROCESS | 29490 | _x_x_mozilla_cycle_collect,1834 12:51:20 INFO - PROCESS | 29490 | __end_cc_report 12:51:20 INFO - PROCESS | 29490 | __startTimestamp1462909880796__endTimestamp 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | ------- Summary: start ------- 12:51:20 INFO - PROCESS | 29490 | Number of tests: 14 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.93 (1.7%) stddev-sans-first:2.05 12:51:20 INFO - PROCESS | 29490 | Values: 110.0 106.0 111.0 111.0 111.0 112.0 113.0 109.0 110.0 109.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:156.50 stddev:28.16 (18.0%) stddev-sans-first:29.79 12:51:20 INFO - PROCESS | 29490 | Values: 158.0 124.0 155.0 208.0 126.0 162.0 150.0 128.0 185.0 125.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 12:51:20 INFO - PROCESS | 29490 | Values: 160.0 161.0 159.0 160.0 159.0 161.0 161.0 162.0 162.0 160.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#3] audio-fft Cycles:10 Average:88.40 Median:75.00 stddev:27.09 (36.1%) stddev-sans-first:28.30 12:51:20 INFO - PROCESS | 29490 | Values: 75.0 75.0 75.0 145.0 76.0 74.0 75.0 79.0 134.0 76.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:91.00 stddev:22.73 (25.0%) stddev-sans-first:23.70 12:51:20 INFO - PROCESS | 29490 | Values: 93.0 91.0 155.0 92.0 91.0 91.0 125.0 92.0 91.0 127.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:51:20 INFO - PROCESS | 29490 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 12:51:20 INFO - PROCESS | 29490 | Values: 147.0 147.0 147.0 145.0 145.0 146.0 145.0 146.0 147.0 146.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 12:51:20 INFO - PROCESS | 29490 | Values: 94.0 97.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:57.00 stddev:16.84 (29.6%) stddev-sans-first:17.80 12:51:20 INFO - PROCESS | 29490 | Values: 58.0 57.0 59.0 57.0 56.0 57.0 58.0 110.0 55.0 55.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 12:51:20 INFO - PROCESS | 29490 | Values: 58.0 59.0 59.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:79.50 stddev:4.23 (5.3%) stddev-sans-first:4.43 12:51:20 INFO - PROCESS | 29490 | Values: 79.0 79.0 92.0 80.0 78.0 79.0 80.0 79.0 84.0 79.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:127.00 stddev:20.15 (15.9%) stddev-sans-first:21.15 12:51:20 INFO - PROCESS | 29490 | Values: 125.0 126.0 134.0 123.0 122.0 128.0 126.0 123.0 189.0 136.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:2.94 (1.8%) stddev-sans-first:3.10 12:51:20 INFO - PROCESS | 29490 | Values: 167.0 165.0 164.0 163.0 164.0 171.0 169.0 166.0 170.0 163.0 12:51:20 INFO - PROCESS | 29490 | 12:51:20 INFO - PROCESS | 29490 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:2.11 (3.2%) stddev-sans-first:1.87 12:51:20 INFO - PROCESS | 29490 | Values: 69.0 68.0 64.0 65.0 67.0 65.0 63.0 64.0 64.0 68.0 12:51:20 INFO - PROCESS | 29490 | -------- Summary: end -------- 12:51:20 INFO - PROCESS | 29490 | 12:51:21 INFO - TEST-INFO | 29490: exit 0 12:51:21 INFO - TEST-OK | kraken | took 62673ms 12:51:21 INFO - SUITE-END | took 1175s 12:51:21 INFO - Completed test suite (00:19:35) 12:51:21 INFO - javascript benchmark 12:51:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.451296023196, 3142.277276226468, 3168.746500279977, 3178.2054486378406, 3201.63181234158, 5280.4983526564965, 5286.127788914824, 5370.248165256867, 5391.622586418952, 5402.081646120159, 5289.365276166865, 5299.417064122943, 5350.839474815752, 5437.918431223535, 5446.319210098738, 4747.382840230774, 4840.709557426548, 4848.127337079324, 4848.345473361086, 4985.152524070899, 4908.533689299528, 4926.729029903354, 4957.281194226835, 4971.6271279654175, 4975.4527002029745, 4759.690620109682, 4805.543473370024, 4836.854894353175, 4842.1042107210105, 4845.030993801254, 4823.372961515016, 4850.684705494167, 4905.092557876804, 4920.926186107211, 4937.456879743226, 4767.0, 4858.125537403266, 4858.78135483904, 4882.194437917739, 4904.092742842586, 5183.222516622499, 5264.368275806928, 5267.710275934822, 5343.225232341289, 5363.302770639831, 5670.716464176775, 5715.685637289947, 5716.742746576414, 5742.167385729088, 5765.365809760923, 5584.441555844423, 5652.773889044433, 5760.308762948473, 5770.394108618577, 5822.650640961556, 5337.386200586943, 5376.166694162411, 5423.755930983115, 5424.864378390533, 5432.7555260013, 5917.852053698692, 5928.851778705481, 5929.436703513159, 5930.169776231331, 5930.22907022093, 5501.092319767274, 5563.276774019432, 5581.916271255853, 5682.971585142048, 5694.572907031989, 5778.711064446845, 5782.277215348082, 5790.507806836382, 5800.1299805029585, 5825.912611310834, 5719.142128680648, 5734.913976290359, 5737.340205876378, 5738.081906894877, 5740.3685594585395, 5613.747381367848, 5640.041192997201, 5665.3201615806365, 5681.17622944679, 5729.627574207663, 4319.352097185384, 4352.586504282088, 4356.302991521341, 4360.106178233455, 4390.890227744332, 3878.1468077023574, 3891.299566078133, 3899.9610003900166, 3928.7249892507252, 3945.3884647879627, 5271.42014378418, 5334.813281535127, 5370.946290537123, 5376.731163441812, 5379.515843574097, 5702.572307076985, 5715.857103572361, 5722.599418040781, 5724.942750572441, 5730.627509211888, 5411.621186516984, 5422.213779002102, 5427.348718153847, 5429.945700543023, 5472.042392581362, 4850.490698476609, 4877.658563900563, 4881.877953051131, 4903.779329930162, 4970.478099799541, 5851.853703657443, 5872.970635146797, 5888.941110588839, 5889.676067816225, 5923.08192230205, 5717.2853393325, 5718.599698021098, 5726.79956201531, 5729.885402292014, 5751.654900705971, 5689.8008569701515, 5782.2483077199695, 5861.120831875252, 5877.0, 5897.498712609477, 5584.86037849057, 5619.719014049199, 5622.775088996558, 5626.5780066496, 5626.718664066862, 5604.775808967759, 5722.284714410699, 5730.1977723119635, 5734.254546908875, 5734.569907257056, 5538.280023597068, 5597.272354593877, 5597.80407685729, 5621.353544342453, 5624.550035997028, 5595.35653399848, 5632.352279487911, 5636.85907852307, 5646.153077038477, 5650.717464126859, 5328.8401347959625, 5396.811111611075, 5508.586855985737, 5514.0, 5517.917231241615, 5568.109102543735, 5668.178114173505, 5669.4047125051275, 5670.036093863971, 5671.376148623731, 5477.4248703887115, 5488.451154884479, 5490.478404551562, 5491.478309560585, 5530.557555395479], "value": 5273.8489137538045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.9935600643993, 654.5189285874881, 660.1418156396685, 672.5863593889757, 681.543365944817, 41971.0, 43456.0, 43486.782566087204, 47271.29093063598, 47274.763626181906, 43965.7801710991, 44068.11863762723, 44079.559204407946, 44124.0, 44129.7793511032, 8702.434341767797, 8921.643134274622, 8925.241354484877, 8927.241184499293, 8930.464172149692, 8768.69309574165, 8829.293656507496, 8849.823003539957, 8856.911430885673, 8860.734177974638, 8868.467891926473, 8916.15296546827, 8923.241524470428, 8923.910760892373, 8925.41984770991, 8863.157999989991, 8886.511241881693, 8893.199612034949, 8893.599788009555, 8899.95550022249, 8697.304215662733, 8706.042335343107, 8706.521141337224, 8734.0, 8787.472751634858, 40470.0, 40833.59166408327, 40937.38593921094, 40955.795221023705, 41022.589774102176, 3588.6231945645854, 4055.41196526502, 4133.524644665842, 4146.626803587661, 4242.936355954663, 32256.0, 32487.51268730971, 33337.16657083568, 34702.13244668878, 35582.46626300608, 4282.443282373302, 4291.4850217973735, 4304.74171549708, 4338.240807858612, 4339.240632889263, 311724.0, 313486.0, 316680.0, 317197.0, 317538.4123079393, 61379.386206137366, 62099.37900620936, 62141.689291554154, 62144.68927655333, 62201.68899155475, 55713.442865570825, 56749.43250567524, 56773.0, 62201.0, 62238.0, 14434.783478247624, 15184.924075379773, 15330.386784528717, 15346.386144554093, 15347.462838800588, 11934.462949167308, 12012.63962081139, 12021.278723276631, 12027.939860300818, 12031.759364812655, 17348.3060677574, 18963.62072758537, 19027.14377853, 19220.519487012658, 19484.51288717765, 6840.281770414134, 6925.217443434688, 6952.513324067267, 7138.9324568677675, 7198.604076775723, 997.9750506237257, 1023.5291765787821, 1152.2913408253864, 1152.8501294831617, 1194.964151075469, 31205.531917021264, 31807.681923180935, 31826.522602160985, 31855.52216716751, 32390.514142287884, 1177.240679761549, 1178.9646310610694, 1189.3755778216332, 1209.7096696792707, 1211.5638370186725, 16789.24448399825, 16850.494485165465, 17067.743983840253, 17106.828931710523, 17439.0, 142644.2867785675, 142778.0, 142979.0, 143077.28461357835, 143701.0, 54928.0, 56011.43988560062, 56033.43966560364, 56047.71976140175, 56102.43897561054, 1260.87391260875, 1320.953766618183, 1332.0675527131048, 1376.7865980772797, 1391.7425276323913, 25990.87004565041, 33954.66045339515, 33995.15012124618, 34112.65887341095, 34461.31077378388, 52842.0, 53495.0, 53496.465035349145, 53539.464605353445, 53642.19536707031, 316296.0, 323572.0, 323751.0, 323846.0, 323930.0, 24712.752872471046, 25351.0, 28140.155795326173, 28546.0, 44180.55819441893, 44240.33639495474, 45002.77498612617, 47947.280790788864, 48600.270995934385, 48638.5136148634, 38300.6169938297, 40869.59130408658, 40949.0, 41141.79429102835, 41464.34142634261, 41617.79191104146, 41790.373144403464, 41849.372259415526, 41905.92364107126, 42019.7899010503, 40356.394654079624, 40389.79805100956, 41898.79050604728, 42017.369739454545, 42040.78979605083, 35328.0, 36015.45976810298, 36833.26333473262, 37123.0, 37224.81387593153, 27073.45853082888, 27699.58450623202, 28193.0, 28456.430871382872, 28491.572626411034], "value": 19331.709792730424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.38019169329067, 396.7302234480553, 406.38838547985296, 406.5406091117037, 412.8204231159448, 14023.719525609507, 16748.246328915197, 17589.560260993483, 19446.708299375503, 19472.41582752518, 14768.113913165218, 17001.82998170018, 17860.0, 18183.636327273445, 18950.0, 5537.778488860451, 5668.971655141719, 5712.314522257335, 5713.257276554042, 5738.3974682658345, 4122.917541649165, 5486.780528778844, 5902.468777809996, 6299.559030867841, 6317.0, 6256.436920677138, 6286.779962701306, 6328.462080723144, 6331.968340158316, 6364.840878978016, 6204.9069263960855, 6352.36476352361, 6366.076918846765, 6367.5861069030825, 6370.140031095789, 5544.780148367393, 5568.638038527482, 5609.0, 5628.465295796893, 5700.372958974551, 22468.550628987494, 23097.422564435856, 23125.306240812803, 23169.768302317098, 23566.646500302508, 2166.7616562178305, 2272.125231785758, 2677.9330516737236, 2797.2307615405925, 3062.5406189071596, 14616.780748288784, 15139.167345795977, 15338.233088345649, 15555.455559055492, 16235.431759888465, 2020.5150763816578, 2026.9189232430685, 2063.123172651617, 2070.596233734422, 2137.1130980643015, 58706.706466467396, 94270.52864735702, 96634.51682741611, 97335.0, 97368.51315743376, 17307.653846922993, 17436.389726359517, 17721.29114835392, 17877.642447151244, 18129.728054079198, 31872.362552748815, 31987.840060799546, 32002.959718826674, 32169.0, 32269.35461290808, 9273.211776999031, 9382.765430864147, 9485.573149208301, 9566.091221333962, 9571.0, 6532.738690452424, 7522.924770752332, 7841.059072911173, 7847.254510821463, 8045.758627241075, 8416.0, 8636.55656255464, 9031.954840225757, 9038.457692538468, 9072.274218062672, 3253.772235943461, 3285.6385797562248, 3401.727861771052, 3426.901576314888, 3435.7251419886347, 916.4318122763929, 997.9550920208463, 1001.4992503748126, 1010.8584798128268, 1012.6961911426542, 18229.7265541017, 18421.723674144898, 18709.064546772606, 18712.157952892154, 19149.425517234504, 1000.7097941597001, 1003.8217068960373, 1049.4385503755454, 1050.4905121016302, 1055.1453322808395, 10067.597296108073, 10139.138173255209, 10585.0, 10590.57637694499, 10693.946530267454, 488513.0, 506716.0, 507700.0, 509144.0, 518596.0, 57169.42830571724, 71198.0, 84871.57564212139, 93966.0, 94407.0, 1062.5484169228048, 1067.588978243382, 1082.7455547946226, 1086.8587083679072, 1095.6359332631084, 16596.336146554004, 16760.24578893977, 16875.7468637973, 17047.23287452043, 17334.219960101575, 38635.22729545337, 39682.40476392914, 39863.60136398599, 40225.39661905015, 41410.37884431676, 55406.44593554013, 55543.722281388335, 56107.15839262333, 56149.71925140348, 56480.0, 6414.871702566016, 8356.749297521084, 8459.365547583833, 8481.40630155883, 8719.65121395137, 12719.74560508766, 13039.869601303866, 13080.345982700637, 13116.868831311565, 13117.540886068942, 11244.606438774603, 11270.211085224284, 11522.942385288019, 11657.125715571197, 11709.648710538697, 11435.428228588371, 11455.942720286344, 11504.712382190512, 11585.131115166228, 11660.358680272328, 6276.748930042747, 7952.886595876697, 11723.237989530653, 11840.407979600814, 11891.881081189078, 8175.3868459866935, 8196.467229630054, 8197.71308004217, 8302.0, 8442.451240669337, 8446.915530844613, 10215.080642742189, 11449.313041217554, 11624.476898539755, 12017.759644807229], "value": 9909.327038949757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.8613138686126, 1540.684159747252, 1569.1761825041854, 1748.8426041656257, 1886.5000774794682, 8327.541985190812, 8745.956270218649, 8750.6937257196, 8942.955285223581, 8950.820983580325, 8619.65521379144, 8791.912080879189, 8793.95603021984, 8795.560221988891, 8801.735947921572, 2098.0139334512833, 2362.2558893948435, 2413.927582172533, 2433.3429973907037, 2445.058652418814, 2413.9275821725378, 2421.757824217582, 2424.0244200976235, 2424.49085692004, 2426.284246147382, 2345.5308938212343, 2400.375902265415, 2401.5076909233653, 2402.1952645863657, 2405.855648661086, 2086.926957556486, 2324.8140148788143, 2402.3153401280724, 2408.891599877992, 2424.0, 2328.685627440291, 2329.4176455886027, 2331.195737470587, 2331.6152834782242, 2375.6792832967676, 8822.2060014599, 8848.026717061119, 8870.06864279248, 8881.511516866569, 8882.555872206363, 5180.611454140954, 5239.528442440199, 5242.711650859202, 5281.419043905167, 5290.470952904679, 3387.220939183977, 3417.726581873444, 3476.8435420406145, 3536.0, 3543.167355671415, 1123.9269447485888, 1165.4871856383165, 1202.1404695642657, 1225.3873063468266, 1239.5413696932194, 11850.525978960832, 11858.703532411673, 11864.288142711464, 11887.167898247126, 11891.345975971319, 4631.58315751584, 4650.255959046536, 4736.478987311393, 4764.6664733469015, 4790.233562629963, 9848.852267215998, 9858.162056225157, 9860.605575777032, 9881.160101391319, 9886.0, 4865.148598995162, 5179.430262671103, 5284.07528682479, 5291.3385826771655, 5297.735113244323, 4829.782659780319, 4949.158643030693, 4971.328870602495, 5022.146235140035, 5057.418396884332, 4093.7339072960162, 4104.076582768913, 4148.605882441163, 4150.91698166035, 4194.706370554032, 1309.3780454284329, 1339.4575197045212, 1341.2958196946681, 1347.036868638928, 1363.8977076719286, 949.4540639132526, 1048.2400259811727, 1051.4690081508943, 1055.8310670292717, 1064.1912146768511, 6246.312905580474, 6324.494040476751, 6371.713272902731, 6387.904181437282, 6502.593379051022, 460.86174147755537, 464.1459714126024, 465.9836905708284, 995.2635050062902, 1077.1221454514703, 4248.511421186541, 4301.677374196947, 4319.97840010798, 4320.719153255029, 4321.481422229353, 11014.834777478345, 11324.15068869838, 11407.0, 11530.250533715282, 11547.364894930859, 11194.888051119548, 11384.146189035855, 11432.314061156358, 11449.885501145049, 11455.369954652408, 7934.246246606564, 8289.212524810133, 8316.708915187939, 8394.24451799341, 8440.649496080598, 6217.564770466205, 6282.780102696383, 6306.274778400542, 6411.71147298382, 6440.033994900615, 9606.567704453177, 10082.890882002826, 10149.898501014895, 10195.0, 10197.694069177936, 9802.460864652227, 10195.23535734808, 10217.33587316822, 10313.845292320771, 10414.791704165722, 8048.557329346942, 8125.918740812753, 8181.140980196994, 8208.712695055645, 8214.424990250625, 8596.097409771884, 8612.870806937775, 8653.17794809492, 8664.176903194186, 8690.174433428814, 7878.763637090897, 8053.798655033671, 8097.635606397608, 8133.511989280662, 8237.876431853407, 7740.1098873628, 7877.487963282369, 7892.0, 7912.84174316522, 7917.168697286702, 7185.317394847481, 7217.819554511179, 7260.4554658401885, 7336.229695881855, 7365.0, 5513.972430137824, 5538.252335934597, 5548.500634942875, 5600.299962504687, 5711.485966263056, 5398.244245805512, 5398.2712333836, 5414.648047876875, 5425.077736784677, 5434.184872269033], "value": 4723.991412763155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.6553785756027, 340.848322496489, 345.69751467465966, 351.50437882585544, 359.0914985087729, 5249.13389290767, 5310.9378124375135, 5320.574354051676, 5378.462153784624, 5381.408045115034, 5268.631195816294, 5268.683878967265, 5287.180487024508, 5307.52232299093, 5308.23030660554, 3746.0260332313524, 3946.2107578484274, 4075.3071977763852, 4126.752394856303, 4208.705390622657, 4151.14901445203, 4168.7081904266715, 4170.624643782059, 4176.68674849386, 4188.874333769976, 4150.260827853617, 4161.708680392374, 4161.895952601194, 4167.916641667165, 4176.624103830654, 3968.8610898618554, 4013.5585085640555, 4133.7106402551835, 4149.356849688304, 4167.458230430055, 3671.541057367829, 3703.907402314937, 3705.277470893177, 3707.888763337104, 3722.5160729105314, 5071.492850714936, 5077.593792496591, 5084.923726144111, 5085.330201644167, 5096.719680417576, 4498.527654596253, 4727.45634252062, 4749.0, 4757.238841785298, 4758.381410416624, 5434.505510984472, 5450.400455949843, 5467.5625949923915, 5490.450954904518, 5529.889402211933, 3965.7620542767236, 3967.305721498726, 3970.1935619293154, 3975.6421922026866, 3985.7608543487486, 5442.455754424565, 5489.4236105209175, 5575.275214222166, 5683.318001839764, 5703.201551782754, 3918.1575961168487, 3950.5654378018394, 3955.20895820837, 4024.557298697141, 4052.7163098583405, 4069.450624165759, 4079.3065178919655, 4079.8168531125643, 4088.6115818997146, 4107.589241075869, 4560.293154561048, 4639.350490931272, 4650.441946966385, 4672.602828759594, 4673.158831410311, 5424.62027658068, 5513.7794488220825, 5517.668939863541, 5519.9448005520235, 5541.6120871539415, 1383.667919699265, 1418.4255376572505, 1422.50923431416, 1423.3025817349424, 1425.365712258056, 884.823035392924, 897.7396554998977, 910.8477775613853, 931.4457897550947, 933.2906990687127, 4633.096546173464, 4755.714657120584, 4769.35613692154, 4776.928346074812, 4793.825512749329, 4970.577500912391, 4995.900081998412, 5009.6223538526465, 5041.445780724581, 5048.894929618332, 4687.95312046882, 4713.882152946204, 4757.857264282077, 4788.545088216614, 4892.437369702529, 2950.7459329784756, 3012.472817256971, 3014.8794048238265, 3016.3364059906785, 3033.9393212136074, 5804.216430781875, 5824.776796872619, 5838.737256823369, 5850.882982340329, 5859.44335288147, 5583.35791383996, 5765.549641402471, 5773.913391299134, 5780.393058728857, 5817.749183925392, 5825.38833422493, 5866.530677545786, 5885.529157667376, 5919.792807251725, 5944.435278648608, 5386.114859799039, 5763.4524720153195, 5768.192453056659, 5771.441710738161, 5779.393163717918, 5657.349404818334, 5699.458551437607, 5700.201971723879, 5730.856728581819, 5735.54115670737, 5660.716964151694, 5744.741486633196, 5888.0, 5899.38056504078, 5960.940390596039, 3998.680105591604, 4049.453323801249, 4054.2094291612852, 4060.39094135882, 4071.5724848891623, 5629.493345598916, 5663.32040155184, 5711.057675483498, 5745.3105627324985, 5747.626404283708, 5330.813421530228, 5560.914657003624, 5579.8884022320135, 5583.581231407579, 5597.0, 5523.558115350682, 5532.5020748132865, 5545.445455454423, 5563.415841336763, 5587.888242235052, 5278.0, 5435.619506634498, 5474.972625136849, 5481.945180548143, 5481.972590137024, 5576.1356989666665, 5579.358373786904, 5581.804636837691, 5588.497035266845, 5600.411956744483, 5438.199327346499, 5456.863578410572, 5462.617616766947, 5464.398916119144, 5489.1217405214975], "value": 4184.160803905247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.1949377709416, 803.7186984555407, 810.9432339736219, 862.2412277196066, 867.3754896474544, 13115.213087214774, 13432.865671343283, 13447.394867230974, 13555.118917270383, 13607.115537490068, 13496.0, 13515.59453216405, 13546.796798048012, 13553.728925421485, 13575.660608484794, 683.5795985468926, 800.8398320335926, 824.5588610093586, 831.8876951611516, 840.315143158327, 811.5414790643297, 818.3739439328918, 824.5959479854888, 824.6454024769347, 825.1377310710292, 872.7818045488627, 876.2902049340055, 876.776422012386, 877.398981697536, 877.5831480046959, 717.9605121718304, 842.8819965204876, 869.0527325215483, 873.1007062725403, 874.7332063720563, 633.6546582112713, 634.2325785799188, 637.5823835387829, 640.2029473305718, 640.8141638924707, 13151.86848131516, 13173.407196676077, 13185.60443186706, 13189.86810131896, 13208.405621747044, 12807.359632018362, 13254.427311792806, 13258.933705331508, 13276.933615331862, 13441.588633193473, 10805.243632945698, 11078.556857725682, 11218.439078046065, 12049.57826476078, 12425.937870310681, 4502.89989531602, 4506.391637128979, 4560.247559152735, 4594.33382159585, 4698.459677137139, 55335.16997245044, 56329.71835140839, 57511.0, 57737.42262577362, 57770.0, 9990.0, 10033.849492257623, 10920.836187457195, 11243.60647377338, 11262.662120136409, 19079.713804292947, 19138.56460765448, 19230.03849807532, 19339.80660193408, 19350.709739353922, 8072.475289106189, 8109.594520273963, 8136.593170341577, 8380.078191398941, 8439.704610338731, 4618.722876627413, 4677.672562920631, 4784.712917224978, 4835.758212089381, 4844.0, 3483.9477407838904, 3488.66857648523, 3576.803275819855, 3586.049696830342, 3681.4293784463453, 541.5667466027163, 642.8746394453037, 700.0549258500982, 701.9017337572744, 702.2100137345486, 618.8886000519859, 726.2374506767873, 732.8933310700774, 793.8848866914265, 795.6061749434067, 9915.454649994319, 10002.299839011199, 10051.0, 10260.538275777608, 10264.0, 665.6971078159426, 666.6067020457953, 725.8149171961117, 742.5878637356211, 755.9773206803804, 4540.682152249311, 4540.8637740867825, 4703.858884233478, 4856.587190088882, 4881.804727810848, 62808.37191628117, 63277.355877633105, 64802.67598662071, 65291.0, 66037.0, 57622.0, 57904.71047644819, 58434.0, 59192.70403647954, 59601.83402473182, 52600.21099683508, 52775.73612131915, 53482.732586337595, 53629.0, 54368.18447723287, 9031.729048128567, 9172.908270917205, 9276.489793061177, 9387.483688397204, 9509.952450237704, 31644.0, 32047.35905281928, 32060.6793932067, 32162.35675286528, 33256.33487330288, 42260.154796904506, 42459.0, 42669.57330426656, 43173.352399714655, 43560.128797424506, 12491.687707807014, 12586.87413125857, 12710.906092925505, 12765.361731913554, 12792.488300467878, 13560.186388816703, 14066.156030638194, 14332.928335358256, 14451.349689264218, 14960.251987400368, 13075.0, 13150.473981040652, 13243.735125297633, 13250.867491324963, 13677.31613419345, 13016.219026858418, 13063.0, 13834.446622135001, 13864.653383665489, 14149.08030977983, 13117.672058198621, 13394.129381590166, 13478.32608369558, 13590.45638174462, 13895.374708137955, 10524.0, 10594.947025264824, 10761.838572421264, 10813.837792433276, 11118.944405277922, 10783.6225732099, 10894.891051089704, 11028.172887033345, 11055.834162487408, 11059.944700276446], "value": 6887.539653256465, "unit": "score"}], "name": "dromaeo_css", "value": 7184.7457450911725, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 111.0, 111.0, 112.0, 113.0, 109.0, 110.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 155.0, 208.0, 126.0, 162.0, 150.0, 128.0, 185.0, 125.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 159.0, 161.0, 161.0, 162.0, 162.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 145.0, 76.0, 74.0, 75.0, 79.0, 134.0, 76.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 155.0, 92.0, 91.0, 91.0, 125.0, 92.0, 91.0, 127.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 145.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 59.0, 57.0, 56.0, 57.0, 58.0, 110.0, 55.0, 55.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 92.0, 80.0, 78.0, 79.0, 80.0, 79.0, 84.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 134.0, 123.0, 122.0, 128.0, 126.0, 123.0, 189.0, 136.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 164.0, 163.0, 164.0, 171.0, 169.0, 166.0, 170.0, 163.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 64.0, 65.0, 67.0, 65.0, 63.0, 64.0, 64.0, 68.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1541.0000000000002, "alertThreshold": 2.0}]} 12:51:22 INFO - Return code: 0 12:51:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:51:22 ERROR - # TBPL SUCCESS # 12:51:22 INFO - Running post-action listener: _resource_record_post_action 12:51:22 INFO - ##### 12:51:22 INFO - ##### Finished run-tests step (success) 12:51:22 INFO - ##### 12:51:22 INFO - Running post-run listener: _resource_record_post_run 12:51:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 534536192; Read time: 0; Write time: 470416 12:51:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244801536; Read time: 0; Write time: 229220 12:51:23 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289734656; Read time: 0; Write time: 241196 12:51:23 INFO - Running post-run listener: _upload_blobber_files 12:51:23 INFO - Blob upload gear active. 12:51:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:51:23 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 12:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:51:23 INFO - (blobuploader) - INFO - Open directory for files ... 12:51:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:51:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:24 INFO - (blobuploader) - INFO - Done attempting. 12:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:25 INFO - (blobuploader) - INFO - Done attempting. 12:51:25 INFO - (blobuploader) - INFO - Iteration through files over. 12:51:25 INFO - Return code: 0 12:51:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:51:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:51:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54cd7cf1a0d40f6a135f626655683eda3fac30464c4ec8db3f83205ea113289edf3e35a6eaa0f407f383564ad10749affd2ec933dade0a476ff83115421f9c2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56967daa54397ab57e48cacc007f8f44c798ac3764330f7a8b6693e462dde0dcbb5885864865f912aac3b2334f1165062f2858a05f2f1eb861a4574fbfeb8935"} 12:51:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:51:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:51:25 INFO - Contents: 12:51:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54cd7cf1a0d40f6a135f626655683eda3fac30464c4ec8db3f83205ea113289edf3e35a6eaa0f407f383564ad10749affd2ec933dade0a476ff83115421f9c2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56967daa54397ab57e48cacc007f8f44c798ac3764330f7a8b6693e462dde0dcbb5885864865f912aac3b2334f1165062f2858a05f2f1eb861a4574fbfeb8935"} 12:51:25 INFO - Running post-run listener: copy_logs_to_upload_dir 12:51:25 INFO - Copying logs to upload dir... 12:51:25 INFO - mkdir: /builds/slave/test/build/upload/logs 12:51:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.104751 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-10 12:51:25.101271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 12:51:25.105116) ========= 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=652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224 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/sha512/54cd7cf1a0d40f6a135f626655683eda3fac30464c4ec8db3f83205ea113289edf3e35a6eaa0f407f383564ad10749affd2ec933dade0a476ff83115421f9c2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56967daa54397ab57e48cacc007f8f44c798ac3764330f7a8b6693e462dde0dcbb5885864865f912aac3b2334f1165062f2858a05f2f1eb861a4574fbfeb8935"} build_url:https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/OIPblfxIRFaS3U-20ZwzxQ/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/sha512/54cd7cf1a0d40f6a135f626655683eda3fac30464c4ec8db3f83205ea113289edf3e35a6eaa0f407f383564ad10749affd2ec933dade0a476ff83115421f9c2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56967daa54397ab57e48cacc007f8f44c798ac3764330f7a8b6693e462dde0dcbb5885864865f912aac3b2334f1165062f2858a05f2f1eb861a4574fbfeb8935"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 12:51:25.129983) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 12:51:25.130271) ========= 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=652eb03db935cfc1c15ebda0000001ad-1462901505.347958-394128224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 12:51:25.217450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 12:51:25.218007) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 12:51:25.218531) ========= ========= Total master_lag: 0.18 =========