builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1462567375.64 results: success (0) buildid: 20160506124403 builduid: 6435578bbb094c5bae14ef6d166f1853 revision: 1d32762a203507d4f0e7743b8a329ab2bbba9799 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:55.636210) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:55.636759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:55.637090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:55.655935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:55.656766) ========= 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=00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 13:42:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.5M=0s 2016-05-06 13:42:55 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094271 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:55.767793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:55.768171) ========= 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=00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016518 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:55.820804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 13:42:55.821617) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d32762a203507d4f0e7743b8a329ab2bbba9799 --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 1d32762a203507d4f0e7743b8a329ab2bbba9799 --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=00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 13:42:56,027 truncating revision to first 12 chars 2016-05-06 13:42:56,027 Setting DEBUG logging. 2016-05-06 13:42:56,027 attempt 1/10 2016-05-06 13:42:56,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d32762a2035?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 13:42:57,418 unpacking tar archive at: fx-team-1d32762a2035/testing/mozharness/ program finished with exit code 0 elapsedTime=1.675210 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 13:42:57.513919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:57.514886) ========= script_repo_revision: 1d32762a203507d4f0e7743b8a329ab2bbba9799 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:57.515818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:57.516626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 13:42:57.527746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 6 secs) (at 2016-05-06 13:42:57.528214) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:42:57 INFO - MultiFileLogger online at 20160506 13:42:57 in /builds/slave/test 13:42:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:42:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:42:57 INFO - {'append_to_log': False, 13:42:57 INFO - 'base_work_dir': '/builds/slave/test', 13:42:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:42:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:42:57 INFO - 'branch': 'Fx-Team-Non-PGO', 13:42:57 INFO - 'buildbot_json_path': 'buildprops.json', 13:42:57 INFO - 'config_files': ('talos/linux_config.py',), 13:42:57 INFO - 'default_actions': ('clobber', 13:42:57 INFO - 'read-buildbot-config', 13:42:57 INFO - 'download-and-extract', 13:42:57 INFO - 'populate-webroot', 13:42:57 INFO - 'create-virtualenv', 13:42:57 INFO - 'install', 13:42:57 INFO - 'run-tests'), 13:42:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:42:57 INFO - 'download_minidump_stackwalk': True, 13:42:57 INFO - 'download_symbols': 'ondemand', 13:42:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:42:57 INFO - 'tooltool.py': '/tools/tooltool.py', 13:42:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:42:57 INFO - '/tools/misc-python/virtualenv.py')}, 13:42:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:42:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:42:57 INFO - 'installer_path': 'installer.exe', 13:42:57 INFO - 'log_level': 'info', 13:42:57 INFO - 'log_name': 'talos', 13:42:57 INFO - 'log_to_console': True, 13:42:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:42:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:42:57 INFO - 'opt_config_files': (), 13:42:57 INFO - 'pip_index': False, 13:42:57 INFO - 'sps_profile': False, 13:42:57 INFO - 'sps_profile_interval': 0, 13:42:57 INFO - 'suite': 'dromaeojs', 13:42:57 INFO - 'system_bits': '32', 13:42:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:42:57 INFO - 'title': 'talos-linux64-ix-016', 13:42:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:42:57 INFO - 'use_talos_json': True, 13:42:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:42:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:42:57 INFO - 'work_dir': 'build'} 13:42:57 INFO - ##### 13:42:57 INFO - ##### Running clobber step. 13:42:57 INFO - ##### 13:42:57 INFO - Running pre-action listener: _resource_record_pre_action 13:42:57 INFO - Running main action method: clobber 13:42:57 INFO - rmtree: /builds/slave/test/build 13:42:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:42:58 INFO - Running post-action listener: _resource_record_post_action 13:42:58 INFO - ##### 13:42:58 INFO - ##### Finished clobber step (success) 13:42:58 INFO - ##### 13:42:58 INFO - ##### 13:42:58 INFO - ##### Running read-buildbot-config step. 13:42:58 INFO - ##### 13:42:58 INFO - Running pre-action listener: _resource_record_pre_action 13:42:58 INFO - Running main action method: read_buildbot_config 13:42:58 INFO - Using buildbot properties: 13:42:58 INFO - { 13:42:58 INFO - "project": "", 13:42:58 INFO - "product": "firefox", 13:42:58 INFO - "script_repo_revision": "production", 13:42:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:42:58 INFO - "repository": "", 13:42:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:42:58 INFO - "buildid": "20160506124403", 13:42:58 INFO - "pgo_build": "False", 13:42:58 INFO - "basedir": "/builds/slave/test", 13:42:58 INFO - "buildnumber": 1662, 13:42:58 INFO - "slavename": "talos-linux64-ix-016", 13:42:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:42:58 INFO - "platform": "ubuntu64_hw", 13:42:58 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:42:58 INFO - "branch": "fx-team", 13:42:58 INFO - "repo_path": "integration/fx-team", 13:42:58 INFO - "revision": "1d32762a203507d4f0e7743b8a329ab2bbba9799", 13:42:58 INFO - "stage_platform": "linux64", 13:42:58 INFO - "builduid": "6435578bbb094c5bae14ef6d166f1853", 13:42:58 INFO - "slavebuilddir": "test" 13:42:58 INFO - } 13:42:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:42:58 INFO - Running post-action listener: _resource_record_post_action 13:42:58 INFO - ##### 13:42:58 INFO - ##### Finished read-buildbot-config step (success) 13:42:58 INFO - ##### 13:42:58 INFO - ##### 13:42:58 INFO - ##### Running download-and-extract step. 13:42:58 INFO - ##### 13:42:58 INFO - Running pre-action listener: _resource_record_pre_action 13:42:58 INFO - Running main action method: download_and_extract 13:42:58 INFO - mkdir: /builds/slave/test/build/tests 13:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:58 INFO - https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:42:58 INFO - Downloaded 1361 bytes. 13:42:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:42:58 INFO - Using the following test package requirements: 13:42:58 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:42:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:42:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:42:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:58 INFO - u'jsshell-linux-x86_64.zip'], 13:42:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:42:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:42:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:42:58 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:42:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:42:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:42:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:58 INFO - https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:43:00 INFO - Downloaded 22321395 bytes. 13:43:00 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'] 13:43:00 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 13:43:01 INFO - Return code: 0 13:43:01 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 13:43: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')]} 13:43:01 INFO - https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:43:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:43:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:43:02 INFO - Downloaded 22321395 bytes. 13:43:02 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'] 13:43:02 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 13:43:03 INFO - Return code: 0 13:43:03 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')]} 13:43:03 INFO - https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:43:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:43:04 INFO - Downloaded 10840152 bytes. 13:43:04 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'] 13:43:04 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 13:43:04 INFO - Return code: 0 13:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:04 INFO - https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:43:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:43:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:43:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CFMHi7rERda5CB7Wyvdv6g/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 13:43:06 INFO - Downloaded 54840678 bytes. 13:43:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:43:06 INFO - mkdir: /builds/slave/test/properties 13:43:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:43:06 INFO - Writing to file /builds/slave/test/properties/build_url 13:43:06 INFO - Contents: 13:43:06 INFO - build_url:https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:43:06 INFO - Running post-action listener: _resource_record_post_action 13:43:06 INFO - Running post-action listener: set_extra_try_arguments 13:43:06 INFO - ##### 13:43:06 INFO - ##### Finished download-and-extract step (success) 13:43:06 INFO - ##### 13:43:06 INFO - ##### 13:43:06 INFO - ##### Running populate-webroot step. 13:43:06 INFO - ##### 13:43:06 INFO - Running pre-action listener: _resource_record_pre_action 13:43:06 INFO - Running main action method: populate_webroot 13:43:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:43:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:43:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:43:06 INFO - '--tppagecycles', 13:43:06 INFO - '7'], 13:43:06 INFO - 'tests': ['tsvgm']}}, 13:43:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:43:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:43:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:43:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:43:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:06 INFO - 'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:06 INFO - 'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['damp', 'tps']}, 13:43:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:06 INFO - 'tests': ['damp', 'tps']}, 13:43:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['dromaeo_dom']}, 13:43:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:43:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['a11yr', 13:43:06 INFO - 'ts_paint', 13:43:06 INFO - 'tpaint', 13:43:06 INFO - 'sessionrestore', 13:43:06 INFO - 'sessionrestore_no_auto_restore', 13:43:06 INFO - 'tabpaint']}, 13:43:06 INFO - 'other-e10s': {'tests': ['a11yr', 13:43:06 INFO - 'ts_paint', 13:43:06 INFO - 'tpaint', 13:43:06 INFO - 'sessionrestore', 13:43:06 INFO - 'sessionrestore_no_auto_restore', 13:43:06 INFO - 'tabpaint']}, 13:43:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:43:06 INFO - 'ts_paint', 13:43:06 INFO - 'tpaint', 13:43:06 INFO - 'sessionrestore', 13:43:06 INFO - 'sessionrestore_no_auto_restore', 13:43:06 INFO - 'tabpaint']}, 13:43:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:43:06 INFO - 'ts_paint', 13:43:06 INFO - 'tpaint', 13:43:06 INFO - 'sessionrestore', 13:43:06 INFO - 'sessionrestore_no_auto_restore', 13:43:06 INFO - 'tabpaint']}, 13:43:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['a11yr', 13:43:06 INFO - 'ts_paint', 13:43:06 INFO - 'tpaint', 13:43:06 INFO - 'sessionrestore', 13:43:06 INFO - 'sessionrestore_no_auto_restore', 13:43:06 INFO - 'tabpaint']}, 13:43:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['a11yr', 13:43:06 INFO - 'ts_paint', 13:43:06 INFO - 'tpaint', 13:43:06 INFO - 'sessionrestore', 13:43:06 INFO - 'sessionrestore_no_auto_restore', 13:43:06 INFO - 'tabpaint']}, 13:43:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['tsvgx', 13:43:06 INFO - 'tsvgr_opacity', 13:43:06 INFO - 'tart', 13:43:06 INFO - 'tscrollx', 13:43:06 INFO - 'cart']}, 13:43:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:43:06 INFO - 'tsvgr_opacity', 13:43:06 INFO - 'tart', 13:43:06 INFO - 'tscrollx', 13:43:06 INFO - 'cart']}, 13:43:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:06 INFO - 'talos_options': ['--disable-e10s'], 13:43:06 INFO - 'tests': ['tp5o']}, 13:43:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:06 INFO - 'tests': ['tp5o']}, 13:43:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:06 INFO - 'talos_options': ['--disable-e10s', 13:43:06 INFO - '--xperf_path', 13:43:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:06 INFO - 'tests': ['tp5n']}, 13:43:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:06 INFO - 'talos_options': ['--xperf_path', 13:43:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:06 INFO - 'tests': ['tp5n']}}, 13:43:06 INFO - 'talos.zip': {'path': '', 13:43:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:06 INFO - Running post-action listener: _resource_record_post_action 13:43:06 INFO - ##### 13:43:06 INFO - ##### Finished populate-webroot step (success) 13:43:06 INFO - ##### 13:43:06 INFO - ##### 13:43:06 INFO - ##### Running create-virtualenv step. 13:43:06 INFO - ##### 13:43:06 INFO - Running pre-action listener: _resource_record_pre_action 13:43:06 INFO - Running main action method: create_virtualenv 13:43:06 INFO - Creating virtualenv /builds/slave/test/build/venv 13:43:06 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 13:43:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:43:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:07 INFO - Using real prefix '/usr' 13:43:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:43:07 INFO - Installing distribute.............................................................................................................................................................................................done. 13:43:09 INFO - Installing pip.................done. 13:43:09 INFO - Return code: 0 13:43:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43: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', 'pip>=1.5'] in /builds/slave/test/build 13:43: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 pip>=1.5 13:43:09 INFO - Using env: {'DISPLAY': ':0', 13:43:09 INFO - 'HOME': '/home/cltbld', 13:43:09 INFO - 'LANG': 'en_US.UTF-8', 13:43:09 INFO - 'LANGUAGE': 'en_US:en', 13:43:09 INFO - 'LOGNAME': 'cltbld', 13:43:09 INFO - 'MAIL': '/var/mail/cltbld', 13:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:09 INFO - 'MOZ_NO_REMOTE': '1', 13:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:09 INFO - 'NO_EM_RESTART': '1', 13:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:09 INFO - 'PWD': '/builds/slave/test', 13:43:09 INFO - 'SHELL': '/bin/bash', 13:43:09 INFO - 'SHLVL': '1', 13:43:09 INFO - 'TERM': 'linux', 13:43:09 INFO - 'TMOUT': '86400', 13:43:09 INFO - 'USER': 'cltbld', 13:43:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:09 INFO - '_': '/tools/buildbot/bin/python'} 13:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:09 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 13:43:09 INFO - Cleaning up... 13:43:09 INFO - Return code: 0 13:43:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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', '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 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43: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', 'psutil>=0.7.1'] in /builds/slave/test/build 13:43: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 psutil>=0.7.1 13:43:09 INFO - Using env: {'DISPLAY': ':0', 13:43:09 INFO - 'HOME': '/home/cltbld', 13:43:09 INFO - 'LANG': 'en_US.UTF-8', 13:43:09 INFO - 'LANGUAGE': 'en_US:en', 13:43:09 INFO - 'LOGNAME': 'cltbld', 13:43:09 INFO - 'MAIL': '/var/mail/cltbld', 13:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:09 INFO - 'MOZ_NO_REMOTE': '1', 13:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:09 INFO - 'NO_EM_RESTART': '1', 13:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:09 INFO - 'PWD': '/builds/slave/test', 13:43:09 INFO - 'SHELL': '/bin/bash', 13:43:09 INFO - 'SHLVL': '1', 13:43:09 INFO - 'TERM': 'linux', 13:43:09 INFO - 'TMOUT': '86400', 13:43:09 INFO - 'USER': 'cltbld', 13:43:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:09 INFO - '_': '/tools/buildbot/bin/python'} 13:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:09 INFO - Downloading/unpacking psutil>=0.7.1 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:43:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:11 INFO - Installing collected packages: psutil 13:43:11 INFO - Running setup.py install for psutil 13:43:12 INFO - building 'psutil._psutil_linux' extension 13:43:12 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 13:43:12 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 13:43:12 INFO - building 'psutil._psutil_posix' extension 13:43:12 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 13:43:12 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 13:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:12 INFO - Successfully installed psutil 13:43:12 INFO - Cleaning up... 13:43:12 INFO - Return code: 0 13:43:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:12 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 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43:12 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 13:43:12 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 13:43:12 INFO - Using env: {'DISPLAY': ':0', 13:43:12 INFO - 'HOME': '/home/cltbld', 13:43:12 INFO - 'LANG': 'en_US.UTF-8', 13:43:12 INFO - 'LANGUAGE': 'en_US:en', 13:43:12 INFO - 'LOGNAME': 'cltbld', 13:43:12 INFO - 'MAIL': '/var/mail/cltbld', 13:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:12 INFO - 'MOZ_NO_REMOTE': '1', 13:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:12 INFO - 'NO_EM_RESTART': '1', 13:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:12 INFO - 'PWD': '/builds/slave/test', 13:43:12 INFO - 'SHELL': '/bin/bash', 13:43:12 INFO - 'SHLVL': '1', 13:43:12 INFO - 'TERM': 'linux', 13:43:12 INFO - 'TMOUT': '86400', 13:43:12 INFO - 'USER': 'cltbld', 13:43:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:12 INFO - '_': '/tools/buildbot/bin/python'} 13:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:43:14 INFO - Installing collected packages: mozsystemmonitor 13:43:14 INFO - Running setup.py install for mozsystemmonitor 13:43:14 INFO - Successfully installed mozsystemmonitor 13:43:14 INFO - Cleaning up... 13:43:14 INFO - Return code: 0 13:43:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:43:14 INFO - Using env: {'DISPLAY': ':0', 13:43:14 INFO - 'HOME': '/home/cltbld', 13:43:14 INFO - 'LANG': 'en_US.UTF-8', 13:43:14 INFO - 'LANGUAGE': 'en_US:en', 13:43:14 INFO - 'LOGNAME': 'cltbld', 13:43:14 INFO - 'MAIL': '/var/mail/cltbld', 13:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:14 INFO - 'MOZ_NO_REMOTE': '1', 13:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:14 INFO - 'NO_EM_RESTART': '1', 13:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:14 INFO - 'PWD': '/builds/slave/test', 13:43:14 INFO - 'SHELL': '/bin/bash', 13:43:14 INFO - 'SHLVL': '1', 13:43:14 INFO - 'TERM': 'linux', 13:43:14 INFO - 'TMOUT': '86400', 13:43:14 INFO - 'USER': 'cltbld', 13:43:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:14 INFO - '_': '/tools/buildbot/bin/python'} 13:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:14 INFO - Downloading/unpacking blobuploader==1.2.4 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:16 INFO - Downloading blobuploader-1.2.4.tar.gz 13:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:43:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:43:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:43:17 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 13:43:17 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 13:43:17 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 13:43:17 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 13:43:17 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 13:43:17 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 13:43:17 INFO - Downloading docopt-0.6.1.tar.gz 13:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:43:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:43:17 INFO - Running setup.py install for blobuploader 13:43:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:43:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:43:17 INFO - Running setup.py install for requests 13:43:18 INFO - Running setup.py install for docopt 13:43:18 INFO - Successfully installed blobuploader requests docopt 13:43:18 INFO - Cleaning up... 13:43:18 INFO - Return code: 0 13:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:18 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 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43:18 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 13:43:18 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 13:43:18 INFO - Using env: {'DISPLAY': ':0', 13:43:18 INFO - 'HOME': '/home/cltbld', 13:43:18 INFO - 'LANG': 'en_US.UTF-8', 13:43:18 INFO - 'LANGUAGE': 'en_US:en', 13:43:18 INFO - 'LOGNAME': 'cltbld', 13:43:18 INFO - 'MAIL': '/var/mail/cltbld', 13:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:18 INFO - 'MOZ_NO_REMOTE': '1', 13:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:18 INFO - 'NO_EM_RESTART': '1', 13:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:18 INFO - 'PWD': '/builds/slave/test', 13:43:18 INFO - 'SHELL': '/bin/bash', 13:43:18 INFO - 'SHLVL': '1', 13:43:18 INFO - 'TERM': 'linux', 13:43:18 INFO - 'TMOUT': '86400', 13:43:18 INFO - 'USER': 'cltbld', 13:43:18 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:18 INFO - '_': '/tools/buildbot/bin/python'} 13:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:18 INFO - Running setup.py (path:/tmp/pip-pBYxpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:18 INFO - Running setup.py (path:/tmp/pip-0HXBBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:18 INFO - Running setup.py (path:/tmp/pip-_lKJER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:18 INFO - Running setup.py (path:/tmp/pip-NGosyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:18 INFO - Running setup.py (path:/tmp/pip-ZpZUpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:18 INFO - Running setup.py (path:/tmp/pip-HKagQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:18 INFO - Running setup.py (path:/tmp/pip-BxoeyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:18 INFO - Running setup.py (path:/tmp/pip-N5NPJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:19 INFO - Running setup.py (path:/tmp/pip-Kx6b6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:19 INFO - Running setup.py (path:/tmp/pip-amnHj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:19 INFO - Running setup.py (path:/tmp/pip-aaiofL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:19 INFO - Running setup.py (path:/tmp/pip-ixR0_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:19 INFO - Running setup.py (path:/tmp/pip-bU3rBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:19 INFO - Running setup.py (path:/tmp/pip-oXaRtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:19 INFO - Running setup.py (path:/tmp/pip-ZSZ36o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:19 INFO - Running setup.py (path:/tmp/pip-KEG2ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:19 INFO - Running setup.py (path:/tmp/pip-b2egXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:43:19 INFO - Running setup.py install for manifestparser 13:43:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:43:19 INFO - Running setup.py install for mozcrash 13:43:19 INFO - Running setup.py install for mozdebug 13:43:19 INFO - Running setup.py install for mozdevice 13:43:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Running setup.py install for mozfile 13:43:20 INFO - Running setup.py install for mozhttpd 13:43:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Running setup.py install for mozinfo 13:43:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Running setup.py install for mozInstall 13:43:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Running setup.py install for mozleak 13:43:20 INFO - Running setup.py install for mozlog 13:43:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Running setup.py install for moznetwork 13:43:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Running setup.py install for mozprocess 13:43:20 INFO - Running setup.py install for mozprofile 13:43:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:43:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:43:21 INFO - Running setup.py install for mozrunner 13:43:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:43:21 INFO - Running setup.py install for mozscreenshot 13:43:21 INFO - Running setup.py install for moztest 13:43:21 INFO - Running setup.py install for mozversion 13:43:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:43:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:43:21 INFO - Cleaning up... 13:43:21 INFO - Return code: 0 13:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:21 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')]} 13:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:21 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')]} 13:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:21 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 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43:21 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 13:43:21 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 13:43:21 INFO - Using env: {'DISPLAY': ':0', 13:43:21 INFO - 'HOME': '/home/cltbld', 13:43:21 INFO - 'LANG': 'en_US.UTF-8', 13:43:21 INFO - 'LANGUAGE': 'en_US:en', 13:43:21 INFO - 'LOGNAME': 'cltbld', 13:43:21 INFO - 'MAIL': '/var/mail/cltbld', 13:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:21 INFO - 'MOZ_NO_REMOTE': '1', 13:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:21 INFO - 'NO_EM_RESTART': '1', 13:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:21 INFO - 'PWD': '/builds/slave/test', 13:43:21 INFO - 'SHELL': '/bin/bash', 13:43:21 INFO - 'SHLVL': '1', 13:43:21 INFO - 'TERM': 'linux', 13:43:21 INFO - 'TMOUT': '86400', 13:43:21 INFO - 'USER': 'cltbld', 13:43:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:21 INFO - '_': '/tools/buildbot/bin/python'} 13:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:21 INFO - Running setup.py (path:/tmp/pip-8NU4Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:21 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)) 13:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:21 INFO - Running setup.py (path:/tmp/pip-I2ePm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:21 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)) 13:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:21 INFO - Running setup.py (path:/tmp/pip-I5C_pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:21 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)) 13:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:21 INFO - Running setup.py (path:/tmp/pip-7QLLFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:21 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)) 13:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:21 INFO - Running setup.py (path:/tmp/pip-Pg134K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:22 INFO - Running setup.py (path:/tmp/pip-0JPkLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:22 INFO - Running setup.py (path:/tmp/pip-Pg419U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:22 INFO - Running setup.py (path:/tmp/pip-1ZZQ_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:22 INFO - Running setup.py (path:/tmp/pip-awq7e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:22 INFO - Running setup.py (path:/tmp/pip-kU7okl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:22 INFO - Running setup.py (path:/tmp/pip-cWaUmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:22 INFO - Running setup.py (path:/tmp/pip-LR1EPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:22 INFO - Running setup.py (path:/tmp/pip-n7WKpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:22 INFO - Running setup.py (path:/tmp/pip-uhYS9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:22 INFO - Running setup.py (path:/tmp/pip-4d7M6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:22 INFO - Running setup.py (path:/tmp/pip-Mh4JVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:22 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)) 13:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:22 INFO - Running setup.py (path:/tmp/pip-j2ucpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:22 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)) 13:43:22 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)) 13:43:22 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)) 13:43:22 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)) 13:43:22 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)) 13:43:22 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)) 13:43:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:24 INFO - Downloading blessings-1.6.tar.gz 13:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:43:24 INFO - Installing collected packages: blessings 13:43:24 INFO - Running setup.py install for blessings 13:43:24 INFO - Successfully installed blessings 13:43:24 INFO - Cleaning up... 13:43:25 INFO - Return code: 0 13:43:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:25 INFO - Reading from file tmpfile_stdout 13:43:25 INFO - Current package versions: 13:43:25 INFO - argparse == 1.2.1 13:43:25 INFO - blessings == 1.6 13:43:25 INFO - blobuploader == 1.2.4 13:43:25 INFO - docopt == 0.6.1 13:43:25 INFO - manifestparser == 1.1 13:43:25 INFO - mozInstall == 1.12 13:43:25 INFO - mozcrash == 0.17 13:43:25 INFO - mozdebug == 0.1 13:43:25 INFO - mozdevice == 0.48 13:43:25 INFO - mozfile == 1.2 13:43:25 INFO - mozhttpd == 0.7 13:43:25 INFO - mozinfo == 0.9 13:43:25 INFO - mozleak == 0.1 13:43:25 INFO - mozlog == 3.1 13:43:25 INFO - moznetwork == 0.27 13:43:25 INFO - mozprocess == 0.22 13:43:25 INFO - mozprofile == 0.28 13:43:25 INFO - mozrunner == 6.11 13:43:25 INFO - mozscreenshot == 0.1 13:43:25 INFO - mozsystemmonitor == 0.0 13:43:25 INFO - moztest == 0.7 13:43:25 INFO - mozversion == 1.4 13:43:25 INFO - psutil == 3.1.1 13:43:25 INFO - requests == 1.2.3 13:43:25 INFO - wsgiref == 0.1.2 13:43:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:25 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 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43:25 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 13:43:25 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 13:43:25 INFO - Using env: {'DISPLAY': ':0', 13:43:25 INFO - 'HOME': '/home/cltbld', 13:43:25 INFO - 'LANG': 'en_US.UTF-8', 13:43:25 INFO - 'LANGUAGE': 'en_US:en', 13:43:25 INFO - 'LOGNAME': 'cltbld', 13:43:25 INFO - 'MAIL': '/var/mail/cltbld', 13:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:25 INFO - 'MOZ_NO_REMOTE': '1', 13:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:25 INFO - 'NO_EM_RESTART': '1', 13:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:25 INFO - 'PWD': '/builds/slave/test', 13:43:25 INFO - 'SHELL': '/bin/bash', 13:43:25 INFO - 'SHLVL': '1', 13:43:25 INFO - 'TERM': 'linux', 13:43:25 INFO - 'TMOUT': '86400', 13:43:25 INFO - 'USER': 'cltbld', 13:43:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:25 INFO - '_': '/tools/buildbot/bin/python'} 13:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 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)) 13:43:25 INFO - Cleaning up... 13:43:25 INFO - Return code: 0 13:43:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43: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', 'jsonschema'] in /builds/slave/test/build 13:43: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 jsonschema 13:43:25 INFO - Using env: {'DISPLAY': ':0', 13:43:25 INFO - 'HOME': '/home/cltbld', 13:43:25 INFO - 'LANG': 'en_US.UTF-8', 13:43:25 INFO - 'LANGUAGE': 'en_US:en', 13:43:25 INFO - 'LOGNAME': 'cltbld', 13:43:25 INFO - 'MAIL': '/var/mail/cltbld', 13:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:25 INFO - 'MOZ_NO_REMOTE': '1', 13:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:25 INFO - 'NO_EM_RESTART': '1', 13:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:25 INFO - 'PWD': '/builds/slave/test', 13:43:25 INFO - 'SHELL': '/bin/bash', 13:43:25 INFO - 'SHLVL': '1', 13:43:25 INFO - 'TERM': 'linux', 13:43:25 INFO - 'TMOUT': '86400', 13:43:25 INFO - 'USER': 'cltbld', 13:43:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:25 INFO - '_': '/tools/buildbot/bin/python'} 13:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:25 INFO - Downloading/unpacking jsonschema 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:43:27 INFO - Downloading/unpacking functools32 (from jsonschema) 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:27 INFO - Downloading functools32-3.2.3-2.tar.gz 13:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:43:27 INFO - warning: no files found matching '*.txt' 13:43:27 INFO - no previously-included directories found matching 'build' 13:43:27 INFO - no previously-included directories found matching 'dist' 13:43:27 INFO - no previously-included directories found matching '.git*' 13:43:27 INFO - Installing collected packages: jsonschema, functools32 13:43:27 INFO - Running setup.py install for functools32 13:43:27 INFO - warning: no files found matching '*.txt' 13:43:27 INFO - no previously-included directories found matching 'build' 13:43:27 INFO - no previously-included directories found matching 'dist' 13:43:27 INFO - no previously-included directories found matching '.git*' 13:43:27 INFO - Successfully installed jsonschema functools32 13:43:27 INFO - Cleaning up... 13:43:28 INFO - Return code: 0 13:43:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:28 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 0x7f203dcfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ecd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, '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': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', '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 13:43:28 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 13:43:28 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 13:43:28 INFO - Using env: {'DISPLAY': ':0', 13:43:28 INFO - 'HOME': '/home/cltbld', 13:43:28 INFO - 'LANG': 'en_US.UTF-8', 13:43:28 INFO - 'LANGUAGE': 'en_US:en', 13:43:28 INFO - 'LOGNAME': 'cltbld', 13:43:28 INFO - 'MAIL': '/var/mail/cltbld', 13:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:28 INFO - 'MOZ_NO_REMOTE': '1', 13:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:28 INFO - 'NO_EM_RESTART': '1', 13:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:28 INFO - 'PWD': '/builds/slave/test', 13:43:28 INFO - 'SHELL': '/bin/bash', 13:43:28 INFO - 'SHLVL': '1', 13:43:28 INFO - 'TERM': 'linux', 13:43:28 INFO - 'TMOUT': '86400', 13:43:28 INFO - 'USER': 'cltbld', 13:43:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:28 INFO - '_': '/tools/buildbot/bin/python'} 13:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:28 INFO - Downloading/unpacking flake8 13:43:28 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 13:43:28 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 13:43:28 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 13:43:28 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 13:43:28 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 13:43:28 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 13:43:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:43:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:43:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 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 13:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:43:30 INFO - no previously-included directories found matching 'docs/_build' 13:43:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:43:30 INFO - Running setup.py install for pep8 13:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:43:30 INFO - no previously-included directories found matching 'docs/_build' 13:43:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:43:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:43:30 INFO - Cleaning up... 13:43:31 INFO - Return code: 0 13:43:31 INFO - Running post-action listener: _resource_record_post_action 13:43:31 INFO - Running post-action listener: _start_resource_monitoring 13:43:31 INFO - Starting resource monitoring. 13:43:31 INFO - ##### 13:43:31 INFO - ##### Finished create-virtualenv step (success) 13:43:31 INFO - ##### 13:43:31 INFO - ##### 13:43:31 INFO - ##### Running install step. 13:43:31 INFO - ##### 13:43:31 INFO - Running pre-action listener: _resource_record_pre_action 13:43:31 INFO - Running main action method: install 13:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:31 INFO - Reading from file tmpfile_stdout 13:43:31 INFO - Detecting whether we're running mozinstall >=1.0... 13:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:43:31 INFO - Reading from file tmpfile_stdout 13:43:31 INFO - Output received: 13:43:31 INFO - Usage: mozinstall [options] installer 13:43:31 INFO - Options: 13:43:31 INFO - -h, --help show this help message and exit 13:43:31 INFO - -d DEST, --destination=DEST 13:43:31 INFO - Directory to install application into. [default: 13:43:31 INFO - "/builds/slave/test"] 13:43:31 INFO - --app=APP Application being installed. [default: firefox] 13:43:31 INFO - mkdir: /builds/slave/test/build/application 13:43:31 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'] 13:43:31 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 13:43:47 INFO - Reading from file tmpfile_stdout 13:43:47 INFO - Output received: 13:43:47 INFO - /builds/slave/test/build/application/firefox/firefox 13:43:47 INFO - Running post-action listener: _resource_record_post_action 13:43:47 INFO - ##### 13:43:47 INFO - ##### Finished install step (success) 13:43:47 INFO - ##### 13:43:47 INFO - ##### 13:43:47 INFO - ##### Running run-tests step. 13:43:47 INFO - ##### 13:43:47 INFO - Running pre-action listener: _resource_record_pre_action 13:43:47 INFO - Running main action method: run_tests 13:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:43:47 INFO - Python 2.7.3 13:43:47 INFO - Return code: 0 13:43:47 INFO - grabbing minidump binary from tooltool 13:43: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')]} 13:43:47 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 0x1f5c410>, '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 0x1f5d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:43:47 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 13:43:47 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 13:43:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:43:47 INFO - Return code: 0 13:43:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:43:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:43:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:43:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:43:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:43:48 INFO - Return code: 0 13:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 13:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 13:43:48 INFO - Using env: {'DISPLAY': ':0', 13:43:48 INFO - 'HOME': '/home/cltbld', 13:43:48 INFO - 'LANG': 'en_US.UTF-8', 13:43:48 INFO - 'LANGUAGE': 'en_US:en', 13:43:48 INFO - 'LOGNAME': 'cltbld', 13:43:48 INFO - 'MAIL': '/var/mail/cltbld', 13:43:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:43:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:48 INFO - 'MOZ_NO_REMOTE': '1', 13:43:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:48 INFO - 'NO_EM_RESTART': '1', 13:43:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:48 INFO - 'PWD': '/builds/slave/test', 13:43:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:43:48 INFO - 'SHELL': '/bin/bash', 13:43:48 INFO - 'SHLVL': '1', 13:43:48 INFO - 'TERM': 'linux', 13:43:48 INFO - 'TMOUT': '86400', 13:43:48 INFO - 'USER': 'cltbld', 13:43:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382', 13:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:48 INFO - '_': '/tools/buildbot/bin/python'} 13:43:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 13:43:48 INFO - mozversion application_buildid: 20160506124403 13:43:48 INFO - mozversion application_changeset: 1d32762a203507d4f0e7743b8a329ab2bbba9799 13:43:48 INFO - mozversion application_display_name: Nightly 13:43:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:43:48 INFO - mozversion application_name: Firefox 13:43:48 INFO - mozversion application_remotingname: firefox 13:43:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:43:48 INFO - mozversion application_vendor: Mozilla 13:43:48 INFO - mozversion application_version: 49.0a1 13:43:48 INFO - mozversion platform_buildid: 20160506124403 13:43:48 INFO - mozversion platform_changeset: 1d32762a203507d4f0e7743b8a329ab2bbba9799 13:43:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:43:48 INFO - mozversion platform_version: 49.0a1 13:43:48 INFO - using testdate: 1462567428 13:43:48 INFO - actual date: 1462567428 13:43:48 INFO - starting webserver on 'localhost:48391' 13:43:48 INFO - SUITE-START | Running 2 tests 13:43:48 INFO - TEST-START | dromaeo_css 13:43:48 INFO - operating with platform_type : linux_ 13:43:48 INFO - Initialising browser for dromaeo_css test... 13:43:48 INFO - TEST-INFO | started process 29639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfFWQxQ/profile http://localhost:48391/getInfo.html) 13:43:52 INFO - PROCESS | 29639 | __metrics Screen width/height:1600/1200 13:43:52 INFO - PROCESS | 29639 | colorDepth:24 13:43:52 INFO - PROCESS | 29639 | Browser inner width/height: 1024/697 13:43:52 INFO - PROCESS | 29639 | __metrics 13:43:53 ERROR - PROCESS | 29639 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:43:54 INFO - TEST-INFO | 29639: exit 0 13:43:54 INFO - Browser initialized. 13:43:54 INFO - Running cycle 1/1 for dromaeo_css test... 13:43:54 INFO - TEST-INFO | started process 29717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfFWQxQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:44:06 INFO - PROCESS | 29717 | RSS: Main: 154140672 13:44:06 INFO - PROCESS | 29717 | 13:44:57 INFO - PROCESS | 29717 | 1462567497739 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] 13:47:09 INFO - PROCESS | 29717 | Cycle 1(1): loaded http://localhost:48391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48391/tests/dromaeo/cssquery-ext.html) 13:47:10 INFO - PROCESS | 29717 | RSS: Main: 235589632 13:47:10 INFO - PROCESS | 29717 | 13:50:13 INFO - PROCESS | 29717 | Cycle 1(1): loaded http://localhost:48391/tests/dromaeo/cssquery-ext.html (next: http://localhost:48391/tests/dromaeo/cssquery-jquery.html) 13:50:13 INFO - PROCESS | 29717 | RSS: Main: 245637120 13:50:13 INFO - PROCESS | 29717 | 13:53:15 INFO - PROCESS | 29717 | Cycle 1(1): loaded http://localhost:48391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48391/tests/dromaeo/cssquery-mootools.html) 13:53:16 INFO - PROCESS | 29717 | RSS: Main: 246243328 13:53:16 INFO - PROCESS | 29717 | 13:56:18 INFO - PROCESS | 29717 | Cycle 1(1): loaded http://localhost:48391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48391/tests/dromaeo/cssquery-prototype.html) 13:56:19 INFO - PROCESS | 29717 | RSS: Main: 242425856 13:56:19 INFO - PROCESS | 29717 | 13:59:22 INFO - PROCESS | 29717 | Cycle 1(1): loaded http://localhost:48391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48391/tests/dromaeo/cssquery-yui.html) 13:59:22 INFO - PROCESS | 29717 | RSS: Main: 217640960 13:59:22 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | Cycle 1(1): loaded http://localhost:48391/tests/dromaeo/cssquery-yui.html (next: http://localhost:48391/tests/dromaeo/cssquery-dojo.html) 14:02:25 INFO - PROCESS | 29717 | RSS: Main: 275316736 14:02:25 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | __start_tp_report 14:02:25 INFO - PROCESS | 29717 | _x_x_mozilla_page_load 14:02:25 INFO - PROCESS | 29717 | _x_x_mozilla_page_load_details 14:02:25 INFO - PROCESS | 29717 | |i|pagename|runs| 14:02:25 INFO - PROCESS | 29717 | |0;dojo.html;2625.2255584602544;2638.6833579970407;2672.652555167828;2674.973250267497;2677.6117462967864;4536.070105628347;4586.449626044871;4707.599854012409;4761.952380476198;4810.494898035704;4607.815687372501;4656.138614356347;4742.573168414842;4808.230683090706;4823.541763532458;4205.411242426055;4288.378185163149;4322.7406355618605;4340.218760623086;4478.664100192483;4419.62433193179;4431.202383570956;4440.289553671413;4475.7762111894435;4509.751963641998;4189.162167566499;4211.620954114113;4346.913061738747;4375.649948004152;4387.16643837673;4246.87259382216;4257.87226383209;4266.616004559604;4301.483821941387;4333.696641235115;4309.762963037032;4309.892252693677;4317.5466576009385;4329.631981281564;4358.716683415568;4492.595666390008;4634.652401069933;4641.071785642851;4665.300204969248;4703.059388122355;5114.744262786846;5139.460356662534;5180.197069454241;5185.325907631984;5193.584513238932;5184.326037615086;5198.6880787152895;5223.73881305937;5225.790968361261;5239;4572.0627271409285;4692.4603670577635;4695.483496815347;4701.459332176775;4777.761111944458;5178.223266510054;5206.817761378334;5232.555232805178;5234.13636749932;5237.109691352479;4805.543473370024;4997.550220480174;4999.475055119233;5001.024800163933;5002.049610573979;4967.652264341534;5002.674826136289;5009.44896061433;5011.398632164163;5039.77321020555;4976.4525902150735;4994.625403094782;4996.150654388763;5006.499350065037;5043.2435134730085;4897.706137631682;4958.181899986534;4978.029284289529;4991.725455100004;5030.874228144253;4292.506361768436;4313.094250207429;4320.481542214954;4342.305231163062;4374.868753937387;3741.120836603396;3757.6993840492696;3771.8868433947027;3798.0694729791376;3809.2000679856988;4235.195312890541;4269.466316710411;4345.065810850682;4400.141972315368;4412.0955204183065;5105.719185444762;5115.5396014358885;5134.614903882224;5141.485851414828;5182.870428239325;4411.911761764747;4418.204723149864;4419.248727716296;4427.5351088135285;4469.821207151743;4548.13585418776;4552.226121559343;4557.316402539579;4626.1210370029585;4676.462206846256;4808.591269741971;4820.276958456259;4828.058528586962;4858.975705121523;4861.319415281934;5184.9740751296;5196.298499702643;5197.168453047494;5200.45395233495;5204.0892843752945;4585.266357382803;4602.7698615069785;4617.884552886205;4623.098495793288;4857.781399837087;4819.6867203633055;4886.169351210374;4890.828820991391;4897.069556784199;4942.925856112233;4924.8768780780765;4961.82633607822;4969.304297398439;4982.402111746469;5019.548240658358;4882.633802464758;4925.1873440881855;4957.603391728725;4975.228839529878;5021.72380519075;4982.177940639754;4986;5010.048090862724;5016.924746128738;5053.67151135175;4629.560191781776;4896.926546101882;4945.703257804544;4950.702957822542;4988.775505102207;4865.854024379133;4905.3623029006;4910.754462276944;4916.410030796327;4918.655694101379;4776.59398951093;4788.521147885183;4789.114013907439;4796.472388037243;4836.032793441396 14:02:25 INFO - PROCESS | 29717 | |1;ext.html;603.9094135879617;606.9726862291196;614.5544480251816;615.1725928625997;616.069734700602;28302.150935471942;30919;43208.13583728328;44338.77830610851;44352.556474435245;43082.56917430825;43452.34821477673;43491.34762978558;43518.12963740723;43576.12847743043;7848.999999999985;7992.040955085398;8001.1198768135455;8002.399820013493;8009;7854.528728276293;7980.3615710743;7986.081600615946;7987.321077708372;7987.640556174957;7992.601294773421;8035;8038.075621303537;8043.517388956652;8046.718364857231;7917;7979.441439099207;7996.480228785111;8005.879911801328;8006.439549231585;7861.21387861215;7948.761537153837;7964.362850971908;7964.681412743484;7966.5618390988475;40051.198976020314;40313;40405.59594404048;40448.19103617941;40462.393064104064;3441.913952151191;3451.3269912366845;3875.748076375055;3973.940390894139;3980.3631418972827;30236.546451803242;30274.54588181157;30313.545296820565;30488.390232195452;30810.22974425635;3335.232896433834;3373;3378.763486555942;3478.7564870459078;3495;257725;258026;258463;259533;260639;48498;55412.445875540725;55570.444295556525;57083;57271.41828653698;59647;59815;59988.70005649944;60024;60058.39941600528;15382.846171538142;15556.922215389077;15569.065856048674;15569.922150389402;15575.610609734847;10329.018743219533;11728.120390970711;12016.33910134951;12076.577319793765;12160.939195303967;16043.518694439186;16104.194790260675;16109.355625774837;16173.838261617468;16192.514224573282;6218.1916350875;6333.524985626004;6354.809355719336;6417.807465776034;6491.9350806492275;894.6466145872344;979.0649929317485;985.8126955878361;1073.2862646340097;1090.7327704712395;29418.264543386587;29545.85227073894;29607.25981850471;29968;30071.09786706402;997.3816233935007;998.55065220651;1043.446973104241;1060.8726952765562;1078.8219943709357;15215;15683.843161568466;15692.76460853088;15840.44558440449;15965.68068638644;366434;368266;370760;371403;371455;53340.46659533355;53513.46486535085;53541.732291338296;53568.73215633897;53629.7318513405;1183.4378670131618;1286.2218357893528;1303.3418123847396;1316.8814806667447;1323.2986517145928;28650.28374290576;30293.69706302997;30506.84746576253;30989.44551509278;30999.535006975366;43743.56256437395;43889.78055109704;44136.33795493006;44155.77922110369;44252.336214957446;294557;295472;297824;297925;298416;32447.837760811046;33307.83346083254;33472;39190.80404597959;39499.60500395074;43566.34650480182;43711.56288437075;43897;44352.11295774002;44932.326015110455;37201.4419783698;37821.243575127795;37929.241415172095;38738.80630596829;38879.41680874732;37782.81108594439;37904.810475947445;38200.2359952805;38315.61684383232;38594;36782.816085919396;37347.62652373441;37378.252434950606;37617.81191094027;37629.62370376261;32260.677393225767;33680.3263934715;33715;33939.15152121217;34280.314393712484;25739.356516087246;26038.86980565085;26139.607905881807;26352.868235658698;26438.735612643628 14:02:25 INFO - PROCESS | 29717 | |2;jquery.html;374.677777111684;375.47996025504676;384.17977617786033;391.11998004489897;395.5609273706184;16024.679506409879;17676.204570794314;18400.44798656039;18446.35437759679;18601.488799012128;16584.668306633892;16916.661666766657;17132.400365987192;17839.554011149696;17862.642747145048;5045.84862454127;5188.792448302082;5205.869853253661;5222.7649755760895;5231.293775340338;3682.5028621136207;3861.073342397832;3958.9604103959023;5936.228290322252;5942.970285148568;5863.179154918314;5945.554083443737;5949.67276799778;5975.551833612496;5994.040953447449;5858.297004359461;5881.294244690643;5892.558058145656;5968.492678122365;5982.820515384546;3357.8824741134185;4933.605311575066;5261.921071183935;5268.762905669216;5289.391719952217;20561.69157462639;20710.896445517676;20935.26726564563;21111.788882111137;21155.894220528953;1944.4944314478196;1952.6192392483472;1961.597872436147;2174.956021109876;2538.8984440622353;13018.934905325414;13279.601611951657;13389.933050334783;13547.45810167592;13783.724325513534;1758.1297257857314;1813.156882049853;1814.3559036542101;1845.6677797996356;1865.0767869904348;68237;70290.64854675745;71390.64304678496;71555.99999999948;71638.28361716369;9593.42439453635;9701.52611084169;9850;10047.246456515644;10196.38821670702;13631.386587603582;13688.93155534216;13700.794488082687;13738.244396558086;13815.171089734647;7483.139438964588;7751.806204844924;7777.533347999138;7852.136265010844;7882.448228623941;7386.409087273113;7562.054743157106;7620.276073772982;7667.616619169019;7676.731314403969;6368.936310636835;6383.744650213939;6444.420002199825;6452.483801295885;6464.159659244268;1774.2636805725479;1820.0808591661125;1835.9541011474553;1848.9753719676933;1855.461916044359;883.6288758721353;922.4050487435701;986.5609803637456;1003.518311210623;1030;16122;17010.82989170117;17471.30114795394;17519.824801752075;17938.372156974445;898.734873212404;914.2457472585144;931.6180366050022;939.7838497145694;962.9374090684083;7664.885026724603;9721.270904682036;9833.213342932548;9920.603175872884;10031;172961;173957;174277;389742;389749;61305.63429429087;84307;85332.99999999876;86634.13365866386;90006;915.455304094063;985.9408435493893;996.496769131584;1001.5442973447064;1005.6932635546083;15823.367065317258;15873.444429444913;15995.520134395987;16031.759523607388;16109.758353624939;36743.08142296464;37376.813115934245;37654.435183472815;37834.0541486465;38166.42750358803;45056.324155138354;47482;51861.740691296305;53575;53945.730271348395;7469.551826890404;7544.698212071675;7578.12851522082;7720.845583088195;7752.65113069902;8480.194381533744;11087.944560277147;11486.885131148916;11687.065034797026;11833.349165795964;9984.60061597557;10615.150787936793;10796.67609971702;10817.459127043774;11052.281601695864;10813.891861081289;10848.132149428184;10901.236913415985;10938.781224375627;11140.275882067639;10775;11251.549938002388;11273.71815704614;11296.378699171624;11340.319580825177;7768.300852923264;7866.252705992922;7905.525668459911;7955.641996110305;8118.878216826634;9258.35191536586;10765;10900.781984360427;10983.340999540053;11007.669769906915 14:02:25 INFO - PROCESS | 29717 | |3;mootools.html;1339.9012809496217;1501.0243341827813;1521.5283262188723;1712.3578658003248;1871.457277389557;6573.70418331175;7390.704371825127;7586.165521792605;7631.885521717179;7852.489588176779;7517.774466765992;7689.538627682343;7715.421343399254;7721.30508254257;7737.72917947872;1876.7091100879318;1942.359021522894;1943.8250557449826;2160.8595441296306;2187.628103222448;2145.0883374565824;2204.669299605056;2207.6798864164684;2221.333599920026;2227.721534808149;2157.4282815054025;2177.205320058183;2189.419803752007;2190.5290362572123;2202.8678279303213;1808.4213051823422;2094.6962690409805;2103.905324260404;2133.957320853582;2134.061013154207;2181.3674034530127;2217.3569664797187;2220.9555808883733;2223.9888800556055;2224.177054489849;7562.092548894113;7662.693492260303;7671.194524574895;7684.961575192144;7692.846143077163;4356.912861742779;4485.506594274627;4493.056458143794;4493.393391892086;4495;2584.8578328191943;2670.4392077663715;2773.861306934645;2786.122371452986;2788.5956536302324;839.5130824121994;892.7500299916034;894.516960841145;917.5824999625155;937.0910217089412;10157.339772914736;10158.59365625374;10162.59349626014;10189.490525473771;10191.89808101917;4121.9381709274385;4203.096334288142;4268.445102136702;4282.143571285756;4307.396964424983;8705.216530512283;8763.824723505622;8768.868466972874;8775.780605484913;8783.385163038525;4553.977230113828;4563.634909207255;4564.589186973189;4564.908701825945;4565.0413413183605;3668.816559172084;3991.880243592697;4098.959010409917;4136;4181.895452613709;3605.675489205984;3626.256617393428;3684.1526448916898;3696.2977034363385;3735.7571757835653;1167.4221260476118;1186.6558697977662;1190.2917763930448;1194.0387987669835;1197.9940100299443;879.8636211387245;898.1871406377239;914.8848171974438;918.136951265808;920.4799288402031;5304.230886521433;5365.436629153961;5387.784488620489;5394.163904594794;5447.346318441812;396.2570180910792;403.66697474583;403.8364462392736;407.5150570820773;410.45614560707185;3644.4168932970597;3646.4165733483046;3680.429533422324;3703.333399988028;3765.8681946131755;8878.644854205888;9275.72172834816;9285.72142835716;9301.069893010645;9302.767430814283;9282.582283797245;9302.488363139957;9337.066293370744;9352.39209451397;9352.906470935204;7100.751473698396;7144.714211431485;7297.379722723628;7299.708011679473;7346.449016323797;5229.607779416483;5281.9471805281455;5315.840524784263;5350.892982140414;5386.057439948072;8641.481511109354;8679;8681.348898832486;8773.56132193375;8792.824143517222;8536.103709110454;8788.648454061766;8822.029576746681;8993.910060899307;9015.594298256725;5761.625494342854;6277.18396608438;6404.903926441014;6551.279359270381;6625.834354141185;7319.158296795937;7340.522866013692;7381.8154546136775;7411.444141689502;7427.331540161412;6512.316206798408;6641.601503909781;6673.065770791996;6750.898736518858;6820.7271709133065;6499.512536559682;6506.479481641362;6554.246261679968;6599.439047681001;6599.769008084694;6222.160008398808;6252.374762523893;6279.780207692709;6285;6285.59143655661;4479.417675702138;4596.4714057883775;4652.488226295172;4669.369635099218;4693.178693728652;4611.008633143891;4630.328602352707;4643.558861908248;4695.178343789755;4751.714897106184 14:02:25 INFO - PROCESS | 29717 | |4;prototype.html;299.94151140527595;308.19714643354064;311.92981579144686;316.1211831109516;316.9492881139017;4714.481407045227;4753.595944344735;4762.618990480762;4775.641826862981;4780.8565743027675;4492.505824359326;4573.216445586224;4603.332516785064;4633.305004249364;4717.315989181567;3662.963370366302;3675.0628589709586;3683.889483315505;3755.3052685253315;3784.280986612535;3767.1523907120954;3768.604296548864;3784.526934133233;3785.261873934584;3811.4282857571447;3652.068722475765;3732;3741.6632503074716;3753.2681127180213;3754.2116155607355;3739.813009349549;3763.2097259575385;3766.9434958475645;3775.8112094395447;3775.9433608495897;3349.246419555605;3360;3364.9158771030675;3373.662633736631;3384.561561336422;4547.794834368895;4557.544245575449;4566.49768525462;4571.9314210286875;4574.382458368111;3977.880663580097;4188.832446702128;4213.094184750294;4297.5702429756775;4313.741175529478;4905.460399356068;4929.162042452792;4936.827211047596;4943.8516844494725;4954.331165292675;3530.3645343838098;3538.168530395355;3542.9114272143147;3547.396942519752;3558.3417067842274;5012.373453318335;5139.738515053365;5158.561522270612;5199.986002729469;5201.921971170397;3594.388953877847;3603.5675718913376;3611.602723700391;3617.620149884277;3627.619099994515;3678.6572900890983;3682.9263414731554;3684.299983003221;3695.74129810916;3699.7595156314756;4228.936565951513;4234.745915245096;4239.724417912826;4241.342591898199;4248.235317642854;4802.399700037496;4909.440655524787;4963.305137280783;4968.180250258667;4973.726445045485;1229.9200551964093;1230.7353918907477;1231.4581584102966;1237.3751255615857;1239.727260002798;799.6441583495405;837.6712738586617;859.1108203009854;859.3168431097167;864.8367945113812;4273.9358909616385;4287.2711639021445;4288.23408901257;4289.463817022872;4292.025668192604;4946.932901601031;4966.304717339575;4971.925421118686;4978.850634480971;4983.551480366712;4050.736702114412;4292.283086765319;4292.313229883266;4301.397804307337;4315.352697095461;2635.827056959635;2640.1815437214523;2644.59008853628;2645.5634820254827;2649.2449651849515;4651.604613607881;4655.162070827284;4656.230632359681;4658.604018658452;4680.906381872343;4897;4967.006598680278;5008.173651347487;5023.6985780853265;5275.973620131952;4763.3807605011125;4799.784009719501;4800.279958006257;4807.351007613997;4830.686005409637;5113.718745469035;5125.615578831528;5129.2819005340025;5130.743462826918;5161.81933632321;4904.337914381513;5044.720931394623;5060.493950605058;5063.240513922941;5064.34163558735;4720.952790472052;4798.832040878552;4837.274408838703;4840.419149702058;4845.95154048455;3552.5789684126557;3555.484454754098;3557.8043207623828;3581.838817253282;3593.946090808692;4884.682495637914;5113.769880355468;5116.692998420107;5117.411497677815;5136.152534831711;4947.183714687037;4968.627352948471;4969.751512424436;4990.130674861896;4991.126552853309;4980.676256043345;4985.725785081855;5000.1749711297225;5000.524950129732;5021.5229553192385;4613.261878099488;4672.6495512837355;4932.8520144395725;4956.826511072095;4966.751662416937;4875.609951203966;4938.38270216223;4947.678400903929;4960.082384758687;4981.37732783402;4810.927836082532;4847.587955023862;4871.415430148405;4884.267359895902;4891.388576427947 14:02:25 INFO - PROCESS | 29717 | |5;yui.html;669.8526324208674;711.5837235217396;764.9923500764991;796.6295672512281;803.9758807235785;12393;12450.501979920804;12514.186577872431;12520.874791252085;12570.182938109028;12692.93653531731;12864.035197360188;12919.547815826449;12925.095243332948;13032.739345213091;690.3683129936103;843.7004863273542;863.8833757442727;880.6829541365104;881.3213825354474;870.1820288928419;877.6226222724226;878.2139984713677;878.4158534574532;878.8813510176109;909.6997990663099;917.1516347378648;918.673870775875;918.8667643191733;919.7240827751681;717.7774889784183;882.5895958379384;907.2288554728494;915.972520824373;917.2845180758985;674.3863084593046;676.3946268090081;676.9289224631441;677.0453660338899;677.2110491277656;13134.146280491737;13158.473661053642;13164;13182.538611148564;13186.07697461178;12328.383580821013;12699.809502857464;12720.109592328541;12796.936015319958;13115.344232788419;10959.559226454357;11124.944375278154;11381.886181138165;11408.543658253742;11749.177557570973;4187.644050255702;4215.683823713233;4229.6404805591255;4369.3009118541195;4369.584889435499;45335.319970200144;45644.315335269996;45683.314750278776;45761.31358029632;45832;10281.897181028244;10304.124149447382;10320.896791032144;10327.122194613392;10443.530041148166;18209.635807284045;19094.904525477283;19123.90438047801;19209.32767353164;19231.230750769813;6785.084013658192;7034.472414568928;7072.3634872861685;7081.89377159343;7201.96399018012;3681.7238707097076;3737.0844143185095;3783.356829339019;3906.882793516199;3908.159745654641;2901.956470652942;3027.6366835979825;3029.8485075746567;3031.2876474028585;3034.2262723005933;530.885859540193;531.4605675239635;535.3495502963917;540.3596737865641;542.8561431220729;528.5454509122152;651.8533330000806;655.4101308822003;656.0945894665331;671.1509939925998;8244.464109832841;8448.281896038905;8456.154384561618;8532.317414606816;8688.174623410765;607.3926073926074;612.7059011674421;633.2875515045574;644.3197090679116;648.0590631060005;3780.1872597391693;3788.3813729664694;3812.9809350953624;3868.864589739346;4059.188162367538;36836;36913;39916;52574;52806.471935280926;48004.75997619989;48190;48428;48525.757371212916;49852.25221621679;44094;44108.3383749244;44529;44648.3302750459;45244.0951180968;7525.403735711171;7664.156942736183;7735.806604834924;7756.689732410866;7781.572013539309;28525.714742852306;28930.7106928928;29421.26446838846;29688.257793555335;29868.70131298659;36539.817300913324;38956.2208755829;39771.40342894801;39913.401298981116;40392.59607404006;10448;10500.219044963798;10588.576456941637;10688.41213733221;10755.677329680122;10349.84475232857;10373.118284945864;10953.288036277616;11349.37578433161;11544.82682759776;10128.44293563861;10165;10250.436226007641;10522.684319470429;10696.89303106959;10573.735656608646;10644.84032739525;11024.724381890517;11125.165612578927;11127.610533631285;10444.373337599769;10491.68524944253;10590.947045264724;10997.285176463503;11020.228583999044;9006.954965225132;9007.09929007094;9193.448393096436;9214.121925753385;9430.056994300516;8743.693970710994;8816.603252853509;8869.246114080375;9035.412698174861;9362.438253704799 14:02:25 INFO - PROCESS | 29717 | __end_tp_report 14:02:25 INFO - PROCESS | 29717 | __start_cc_report 14:02:25 INFO - PROCESS | 29717 | _x_x_mozilla_cycle_collect,941 14:02:25 INFO - PROCESS | 29717 | __end_cc_report 14:02:25 INFO - PROCESS | 29717 | __startTimestamp1462568545963__endTimestamp 14:02:25 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | ------- Summary: start ------- 14:02:25 INFO - PROCESS | 29717 | Number of tests: 6 14:02:25 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | [#0] dojo.html Cycles:165 Average:4675.65 Median:4808.23 stddev:494.69 (10.3%) stddev-sans-first:469.33 14:02:25 INFO - PROCESS | 29717 | Values: 2625.2 2638.7 2672.7 2675.0 2677.6 4536.1 4586.4 4707.6 4762.0 4810.5 4607.8 4656.1 4742.6 4808.2 4823.5 4205.4 4288.4 4322.7 4340.2 4478.7 4419.6 4431.2 4440.3 4475.8 4509.8 4189.2 4211.6 4346.9 4375.6 4387.2 4246.9 4257.9 4266.6 4301.5 4333.7 4309.8 4309.9 4317.5 4329.6 4358.7 4492.6 4634.7 4641.1 4665.3 4703.1 5114.7 5139.5 5180.2 5185.3 5193.6 5184.3 5198.7 5223.7 5225.8 5239.0 4572.1 4692.5 4695.5 4701.5 4777.8 5178.2 5206.8 5232.6 5234.1 5237.1 4805.5 4997.6 4999.5 5001.0 5002.0 4967.7 5002.7 5009.4 5011.4 5039.8 4976.5 4994.6 4996.2 5006.5 5043.2 4897.7 4958.2 4978.0 4991.7 5030.9 4292.5 4313.1 4320.5 4342.3 4374.9 3741.1 3757.7 3771.9 3798.1 3809.2 4235.2 4269.5 4345.1 4400.1 4412.1 5105.7 5115.5 5134.6 5141.5 5182.9 4411.9 4418.2 4419.2 4427.5 4469.8 4548.1 4552.2 4557.3 4626.1 4676.5 4808.6 4820.3 4828.1 4859.0 4861.3 5185.0 5196.3 5197.2 5200.5 5204.1 4585.3 4602.8 4617.9 4623.1 4857.8 4819.7 4886.2 4890.8 4897.1 4942.9 4924.9 4961.8 4969.3 4982.4 5019.5 4882.6 4925.2 4957.6 4975.2 5021.7 4982.2 4986.0 5010.0 5016.9 5053.7 4629.6 4896.9 4945.7 4950.7 4988.8 4865.9 4905.4 4910.8 4916.4 4918.7 4776.6 4788.5 4789.1 4796.5 4836.0 14:02:25 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | [#1] ext.html Cycles:180 Average:47760.53 Median:37917.03 stddev:81780.51 (215.7%) stddev-sans-first:81933.28 14:02:25 INFO - PROCESS | 29717 | Values: 603.9 607.0 614.6 615.2 616.1 28302.2 30919.0 43208.1 44338.8 44352.6 43082.6 43452.3 43491.3 43518.1 43576.1 7849.0 7992.0 8001.1 8002.4 8009.0 7854.5 7980.4 7986.1 7987.3 7987.6 7992.6 8035.0 8038.1 8043.5 8046.7 7917.0 7979.4 7996.5 8005.9 8006.4 7861.2 7948.8 7964.4 7964.7 7966.6 40051.2 40313.0 40405.6 40448.2 40462.4 3441.9 3451.3 3875.7 3973.9 3980.4 30236.5 30274.5 30313.5 30488.4 30810.2 3335.2 3373.0 3378.8 3478.8 3495.0 257725.0 258026.0 258463.0 259533.0 260639.0 48498.0 55412.4 55570.4 57083.0 57271.4 59647.0 59815.0 59988.7 60024.0 60058.4 15382.8 15556.9 15569.1 15569.9 15575.6 10329.0 11728.1 12016.3 12076.6 12160.9 16043.5 16104.2 16109.4 16173.8 16192.5 6218.2 6333.5 6354.8 6417.8 6491.9 894.6 979.1 985.8 1073.3 1090.7 29418.3 29545.9 29607.3 29968.0 30071.1 997.4 998.6 1043.4 1060.9 1078.8 15215.0 15683.8 15692.8 15840.4 15965.7 366434.0 368266.0 370760.0 371403.0 371455.0 53340.5 53513.5 53541.7 53568.7 53629.7 1183.4 1286.2 1303.3 1316.9 1323.3 28650.3 30293.7 30506.8 30989.4 30999.5 43743.6 43889.8 44136.3 44155.8 44252.3 294557.0 295472.0 297824.0 297925.0 298416.0 32447.8 33307.8 33472.0 39190.8 39499.6 43566.3 43711.6 43897.0 44352.1 44932.3 37201.4 37821.2 37929.2 38738.8 38879.4 37782.8 37904.8 38200.2 38315.6 38594.0 36782.8 37347.6 37378.3 37617.8 37629.6 32260.7 33680.3 33715.0 33939.2 34280.3 25739.4 26038.9 26139.6 26352.9 26438.7 14:02:25 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | [#2] jquery.html Cycles:180 Average:21192.69 Median:19275.30 stddev:47740.31 (247.7%) stddev-sans-first:47848.64 14:02:25 INFO - PROCESS | 29717 | Values: 374.7 375.5 384.2 391.1 395.6 16024.7 17676.2 18400.4 18446.4 18601.5 16584.7 16916.7 17132.4 17839.6 17862.6 5045.8 5188.8 5205.9 5222.8 5231.3 3682.5 3861.1 3959.0 5936.2 5943.0 5863.2 5945.6 5949.7 5975.6 5994.0 5858.3 5881.3 5892.6 5968.5 5982.8 3357.9 4933.6 5261.9 5268.8 5289.4 20561.7 20710.9 20935.3 21111.8 21155.9 1944.5 1952.6 1961.6 2175.0 2538.9 13018.9 13279.6 13389.9 13547.5 13783.7 1758.1 1813.2 1814.4 1845.7 1865.1 68237.0 70290.6 71390.6 71556.0 71638.3 9593.4 9701.5 9850.0 10047.2 10196.4 13631.4 13688.9 13700.8 13738.2 13815.2 7483.1 7751.8 7777.5 7852.1 7882.4 7386.4 7562.1 7620.3 7667.6 7676.7 6368.9 6383.7 6444.4 6452.5 6464.2 1774.3 1820.1 1836.0 1849.0 1855.5 883.6 922.4 986.6 1003.5 1030.0 16122.0 17010.8 17471.3 17519.8 17938.4 898.7 914.2 931.6 939.8 962.9 7664.9 9721.3 9833.2 9920.6 10031.0 172961.0 173957.0 174277.0 389742.0 389749.0 61305.6 84307.0 85333.0 86634.1 90006.0 915.5 985.9 996.5 1001.5 1005.7 15823.4 15873.4 15995.5 16031.8 16109.8 36743.1 37376.8 37654.4 37834.1 38166.4 45056.3 47482.0 51861.7 53575.0 53945.7 7469.6 7544.7 7578.1 7720.8 7752.7 8480.2 11087.9 11486.9 11687.1 11833.3 9984.6 10615.2 10796.7 10817.5 11052.3 10813.9 10848.1 10901.2 10938.8 11140.3 10775.0 11251.5 11273.7 11296.4 11340.3 7768.3 7866.3 7905.5 7955.6 8118.9 9258.4 10765.0 10900.8 10983.3 11007.7 14:02:25 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | [#3] mootools.html Cycles:180 Average:5032.71 Median:5255.78 stddev:2790.00 (53.1%) stddev-sans-first:2784.02 14:02:25 INFO - PROCESS | 29717 | Values: 1339.9 1501.0 1521.5 1712.4 1871.5 6573.7 7390.7 7586.2 7631.9 7852.5 7517.8 7689.5 7715.4 7721.3 7737.7 1876.7 1942.4 1943.8 2160.9 2187.6 2145.1 2204.7 2207.7 2221.3 2227.7 2157.4 2177.2 2189.4 2190.5 2202.9 1808.4 2094.7 2103.9 2134.0 2134.1 2181.4 2217.4 2221.0 2224.0 2224.2 7562.1 7662.7 7671.2 7685.0 7692.8 4356.9 4485.5 4493.1 4493.4 4495.0 2584.9 2670.4 2773.9 2786.1 2788.6 839.5 892.8 894.5 917.6 937.1 10157.3 10158.6 10162.6 10189.5 10191.9 4121.9 4203.1 4268.4 4282.1 4307.4 8705.2 8763.8 8768.9 8775.8 8783.4 4554.0 4563.6 4564.6 4564.9 4565.0 3668.8 3991.9 4099.0 4136.0 4181.9 3605.7 3626.3 3684.2 3696.3 3735.8 1167.4 1186.7 1190.3 1194.0 1198.0 879.9 898.2 914.9 918.1 920.5 5304.2 5365.4 5387.8 5394.2 5447.3 396.3 403.7 403.8 407.5 410.5 3644.4 3646.4 3680.4 3703.3 3765.9 8878.6 9275.7 9285.7 9301.1 9302.8 9282.6 9302.5 9337.1 9352.4 9352.9 7100.8 7144.7 7297.4 7299.7 7346.4 5229.6 5281.9 5315.8 5350.9 5386.1 8641.5 8679.0 8681.3 8773.6 8792.8 8536.1 8788.6 8822.0 8993.9 9015.6 5761.6 6277.2 6404.9 6551.3 6625.8 7319.2 7340.5 7381.8 7411.4 7427.3 6512.3 6641.6 6673.1 6750.9 6820.7 6499.5 6506.5 6554.2 6599.4 6599.8 6222.2 6252.4 6279.8 6285.0 6285.6 4479.4 4596.5 4652.5 4669.4 4693.2 4611.0 4630.3 4643.6 4695.2 4751.7 14:02:25 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | [#4] prototype.html Cycles:180 Average:4105.62 Median:4653.38 stddev:1182.80 (25.4%) stddev-sans-first:1151.11 14:02:25 INFO - PROCESS | 29717 | Values: 299.9 308.2 311.9 316.1 316.9 4714.5 4753.6 4762.6 4775.6 4780.9 4492.5 4573.2 4603.3 4633.3 4717.3 3663.0 3675.1 3683.9 3755.3 3784.3 3767.2 3768.6 3784.5 3785.3 3811.4 3652.1 3732.0 3741.7 3753.3 3754.2 3739.8 3763.2 3766.9 3775.8 3775.9 3349.2 3360.0 3364.9 3373.7 3384.6 4547.8 4557.5 4566.5 4571.9 4574.4 3977.9 4188.8 4213.1 4297.6 4313.7 4905.5 4929.2 4936.8 4943.9 4954.3 3530.4 3538.2 3542.9 3547.4 3558.3 5012.4 5139.7 5158.6 5200.0 5201.9 3594.4 3603.6 3611.6 3617.6 3627.6 3678.7 3682.9 3684.3 3695.7 3699.8 4228.9 4234.7 4239.7 4241.3 4248.2 4802.4 4909.4 4963.3 4968.2 4973.7 1229.9 1230.7 1231.5 1237.4 1239.7 799.6 837.7 859.1 859.3 864.8 4273.9 4287.3 4288.2 4289.5 4292.0 4946.9 4966.3 4971.9 4978.9 4983.6 4050.7 4292.3 4292.3 4301.4 4315.4 2635.8 2640.2 2644.6 2645.6 2649.2 4651.6 4655.2 4656.2 4658.6 4680.9 4897.0 4967.0 5008.2 5023.7 5276.0 4763.4 4799.8 4800.3 4807.4 4830.7 5113.7 5125.6 5129.3 5130.7 5161.8 4904.3 5044.7 5060.5 5063.2 5064.3 4721.0 4798.8 4837.3 4840.4 4846.0 3552.6 3555.5 3557.8 3581.8 3593.9 4884.7 5113.8 5116.7 5117.4 5136.2 4947.2 4968.6 4969.8 4990.1 4991.1 4980.7 4985.7 5000.2 5000.5 5021.5 4613.3 4672.6 4932.9 4956.8 4966.8 4875.6 4938.4 4947.7 4960.1 4981.4 4810.9 4847.6 4871.4 4884.3 4891.4 14:02:25 INFO - PROCESS | 29717 | 14:02:25 INFO - PROCESS | 29717 | [#5] yui.html Cycles:180 Average:12760.15 Median:4299.47 stddev:14144.78 (329.0%) stddev-sans-first:14155.32 14:02:25 INFO - PROCESS | 29717 | Values: 669.9 711.6 765.0 796.6 804.0 12393.0 12450.5 12514.2 12520.9 12570.2 12692.9 12864.0 12919.5 12925.1 13032.7 690.4 843.7 863.9 880.7 881.3 870.2 877.6 878.2 878.4 878.9 909.7 917.2 918.7 918.9 919.7 717.8 882.6 907.2 916.0 917.3 674.4 676.4 676.9 677.0 677.2 13134.1 13158.5 13164.0 13182.5 13186.1 12328.4 12699.8 12720.1 12796.9 13115.3 10959.6 11124.9 11381.9 11408.5 11749.2 4187.6 4215.7 4229.6 4369.3 4369.6 45335.3 45644.3 45683.3 45761.3 45832.0 10281.9 10304.1 10320.9 10327.1 10443.5 18209.6 19094.9 19123.9 19209.3 19231.2 6785.1 7034.5 7072.4 7081.9 7202.0 3681.7 3737.1 3783.4 3906.9 3908.2 2902.0 3027.6 3029.8 3031.3 3034.2 530.9 531.5 535.3 540.4 542.9 528.5 651.9 655.4 656.1 671.2 8244.5 8448.3 8456.2 8532.3 8688.2 607.4 612.7 633.3 644.3 648.1 3780.2 3788.4 3813.0 3868.9 4059.2 36836.0 36913.0 39916.0 52574.0 52806.5 48004.8 48190.0 48428.0 48525.8 49852.3 44094.0 44108.3 44529.0 44648.3 45244.1 7525.4 7664.2 7735.8 7756.7 7781.6 28525.7 28930.7 29421.3 29688.3 29868.7 36539.8 38956.2 39771.4 39913.4 40392.6 10448.0 10500.2 10588.6 10688.4 10755.7 10349.8 10373.1 10953.3 11349.4 11544.8 10128.4 10165.0 10250.4 10522.7 10696.9 10573.7 10644.8 11024.7 11125.2 11127.6 10444.4 10491.7 10590.9 10997.3 11020.2 9007.0 9007.1 9193.4 9214.1 9430.1 8743.7 8816.6 8869.2 9035.4 9362.4 14:02:25 INFO - PROCESS | 29717 | -------- Summary: end -------- 14:02:25 INFO - PROCESS | 29717 | 14:02:26 INFO - TEST-INFO | 29717: exit 0 14:02:26 INFO - TEST-OK | dromaeo_css | took 1118479ms 14:02:26 INFO - TEST-START | kraken 14:02:26 INFO - operating with platform_type : linux_ 14:02:26 INFO - Initialising browser for kraken test... 14:02:26 INFO - TEST-INFO | started process 29892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppssm1E/profile http://localhost:48391/getInfo.html) 14:02:30 INFO - PROCESS | 29892 | __metrics Screen width/height:1600/1200 14:02:30 INFO - PROCESS | 29892 | colorDepth:24 14:02:30 INFO - PROCESS | 29892 | Browser inner width/height: 1024/697 14:02:30 INFO - PROCESS | 29892 | __metrics 14:02:31 ERROR - PROCESS | 29892 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:02:32 INFO - TEST-INFO | 29892: exit 0 14:02:32 INFO - Browser initialized. 14:02:32 INFO - Running cycle 1/1 for kraken test... 14:02:32 INFO - TEST-INFO | started process 29973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppssm1E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:44 INFO - PROCESS | 29973 | RSS: Main: 154243072 14:02:44 INFO - PROCESS | 29973 | 14:02:47 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48391/tests/kraken/driver.html?testName=audio-beat-detection) 14:02:48 INFO - PROCESS | 29973 | RSS: Main: 210378752 14:02:48 INFO - PROCESS | 29973 | 14:02:51 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48391/tests/kraken/driver.html?testName=audio-dft) 14:02:51 INFO - PROCESS | 29973 | RSS: Main: 197951488 14:02:51 INFO - PROCESS | 29973 | 14:02:54 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48391/tests/kraken/driver.html?testName=audio-fft) 14:02:55 INFO - PROCESS | 29973 | RSS: Main: 266723328 14:02:55 INFO - PROCESS | 29973 | 14:02:57 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48391/tests/kraken/driver.html?testName=audio-oscillator) 14:02:58 INFO - PROCESS | 29973 | RSS: Main: 176132096 14:02:58 INFO - PROCESS | 29973 | 14:03:00 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:03:01 INFO - PROCESS | 29973 | RSS: Main: 180113408 14:03:01 INFO - PROCESS | 29973 | 14:03:04 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48391/tests/kraken/driver.html?testName=imaging-darkroom) 14:03:04 INFO - PROCESS | 29973 | RSS: Main: 215666688 14:03:04 INFO - PROCESS | 29973 | 14:03:08 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48391/tests/kraken/driver.html?testName=imaging-desaturate) 14:03:08 INFO - PROCESS | 29973 | RSS: Main: 216580096 14:03:08 INFO - PROCESS | 29973 | 14:03:11 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48391/tests/kraken/driver.html?testName=json-parse-financial) 14:03:12 INFO - PROCESS | 29973 | RSS: Main: 216969216 14:03:12 INFO - PROCESS | 29973 | 14:03:14 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:14 INFO - PROCESS | 29973 | RSS: Main: 203116544 14:03:14 INFO - PROCESS | 29973 | 14:03:16 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48391/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:03:17 INFO - PROCESS | 29973 | RSS: Main: 207822848 14:03:17 INFO - PROCESS | 29973 | 14:03:19 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:03:20 INFO - PROCESS | 29973 | RSS: Main: 217673728 14:03:20 INFO - PROCESS | 29973 | 14:03:22 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:03:23 INFO - PROCESS | 29973 | RSS: Main: 224317440 14:03:23 INFO - PROCESS | 29973 | 14:03:26 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:03:27 INFO - PROCESS | 29973 | RSS: Main: 220676096 14:03:27 INFO - PROCESS | 29973 | 14:03:28 INFO - PROCESS | 29973 | Cycle 1(1): loaded http://localhost:48391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48391/tests/kraken/driver.html?testName=ai-astar) 14:03:29 INFO - PROCESS | 29973 | RSS: Main: 266194944 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | __start_tp_report 14:03:29 INFO - PROCESS | 29973 | _x_x_mozilla_page_load 14:03:29 INFO - PROCESS | 29973 | _x_x_mozilla_page_load_details 14:03:29 INFO - PROCESS | 29973 | |i|pagename|runs| 14:03:29 INFO - PROCESS | 29973 | |0;ai-astar;114;107;113;113;111;115;112;114;115;112 14:03:29 INFO - PROCESS | 29973 | |1;audio-beat-detection;157;131;152;196;134;156;157;136;188;132 14:03:29 INFO - PROCESS | 29973 | |2;audio-dft;160;160;162;160;161;160;161;161;160;161 14:03:29 INFO - PROCESS | 29973 | |3;audio-fft;75;77;77;124;77;75;77;74;129;76 14:03:29 INFO - PROCESS | 29973 | |4;audio-oscillator;94;94;116;93;93;93;126;93;93;122 14:03:29 INFO - PROCESS | 29973 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;117;117 14:03:29 INFO - PROCESS | 29973 | |6;imaging-darkroom;147;145;147;145;146;145;147;145;146;145 14:03:29 INFO - PROCESS | 29973 | |7;imaging-desaturate;95;94;94;95;95;95;95;94;95;94 14:03:29 INFO - PROCESS | 29973 | |8;json-parse-financial;66;66;66;65;67;66;66;81;65;64 14:03:29 INFO - PROCESS | 29973 | |9;json-stringify-tinderbox;63;64;64;64;65;63;63;64;64;64 14:03:29 INFO - PROCESS | 29973 | |10;stanford-crypto-aes;86;87;82;82;85;88;84;84;84;82 14:03:29 INFO - PROCESS | 29973 | |11;stanford-crypto-ccm;131;137;143;141;130;131;139;129;189;154 14:03:29 INFO - PROCESS | 29973 | |12;stanford-crypto-pbkdf2;171;171;173;172;175;174;174;171;174;170 14:03:29 INFO - PROCESS | 29973 | |13;stanford-crypto-sha256-iterative;69;69;75;67;67;71;70;66;66;70 14:03:29 INFO - PROCESS | 29973 | __end_tp_report 14:03:29 INFO - PROCESS | 29973 | __start_cc_report 14:03:29 INFO - PROCESS | 29973 | _x_x_mozilla_cycle_collect,1867 14:03:29 INFO - PROCESS | 29973 | __end_cc_report 14:03:29 INFO - PROCESS | 29973 | __startTimestamp1462568609055__endTimestamp 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | ------- Summary: start ------- 14:03:29 INFO - PROCESS | 29973 | Number of tests: 14 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:2.37 (2.1%) stddev-sans-first:2.46 14:03:29 INFO - PROCESS | 29973 | Values: 114.0 107.0 113.0 113.0 111.0 115.0 112.0 114.0 115.0 112.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:156.50 stddev:22.81 (14.6%) stddev-sans-first:24.17 14:03:29 INFO - PROCESS | 29973 | Values: 157.0 131.0 152.0 196.0 134.0 156.0 157.0 136.0 188.0 132.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 14:03:29 INFO - PROCESS | 29973 | Values: 160.0 160.0 162.0 160.0 161.0 160.0 161.0 161.0 160.0 161.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#3] audio-fft Cycles:10 Average:86.10 Median:76.50 stddev:21.35 (27.9%) stddev-sans-first:22.27 14:03:29 INFO - PROCESS | 29973 | Values: 75.0 77.0 77.0 124.0 77.0 75.0 77.0 74.0 129.0 76.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:93.00 stddev:13.76 (14.8%) stddev-sans-first:14.31 14:03:29 INFO - PROCESS | 29973 | Values: 94.0 94.0 116.0 93.0 93.0 93.0 126.0 93.0 93.0 122.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:03:29 INFO - PROCESS | 29973 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 14:03:29 INFO - PROCESS | 29973 | Values: 147.0 145.0 147.0 145.0 146.0 145.0 147.0 145.0 146.0 145.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:03:29 INFO - PROCESS | 29973 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:66.00 stddev:4.92 (7.5%) stddev-sans-first:5.20 14:03:29 INFO - PROCESS | 29973 | Values: 66.0 66.0 66.0 65.0 67.0 66.0 66.0 81.0 65.0 64.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 14:03:29 INFO - PROCESS | 29973 | Values: 63.0 64.0 64.0 64.0 65.0 63.0 63.0 64.0 64.0 64.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:2.12 (2.5%) stddev-sans-first:2.17 14:03:29 INFO - PROCESS | 29973 | Values: 86.0 87.0 82.0 82.0 85.0 88.0 84.0 84.0 84.0 82.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:140.00 stddev:18.08 (12.9%) stddev-sans-first:18.70 14:03:29 INFO - PROCESS | 29973 | Values: 131.0 137.0 143.0 141.0 130.0 131.0 139.0 129.0 189.0 154.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.50 stddev:1.72 (1.0%) stddev-sans-first:1.73 14:03:29 INFO - PROCESS | 29973 | Values: 171.0 171.0 173.0 172.0 175.0 174.0 174.0 171.0 174.0 170.0 14:03:29 INFO - PROCESS | 29973 | 14:03:29 INFO - PROCESS | 29973 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:2.75 (4.0%) stddev-sans-first:2.92 14:03:29 INFO - PROCESS | 29973 | Values: 69.0 69.0 75.0 67.0 67.0 71.0 70.0 66.0 66.0 70.0 14:03:29 INFO - PROCESS | 29973 | -------- Summary: end -------- 14:03:29 INFO - PROCESS | 29973 | 14:03:30 INFO - TEST-INFO | 29973: exit 0 14:03:30 INFO - TEST-OK | kraken | took 63297ms 14:03:30 INFO - SUITE-END | took 1181s 14:03:30 INFO - Completed test suite (00:19:41) 14:03:30 INFO - javascript benchmark 14:03:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.2255584602544, 2638.6833579970407, 2672.652555167828, 2674.973250267497, 2677.6117462967864, 4536.070105628347, 4586.449626044871, 4707.599854012409, 4761.952380476198, 4810.494898035704, 4607.815687372501, 4656.138614356347, 4742.573168414842, 4808.230683090706, 4823.541763532458, 4205.411242426055, 4288.378185163149, 4322.7406355618605, 4340.218760623086, 4478.664100192483, 4419.62433193179, 4431.202383570956, 4440.289553671413, 4475.7762111894435, 4509.751963641998, 4189.162167566499, 4211.620954114113, 4346.913061738747, 4375.649948004152, 4387.16643837673, 4246.87259382216, 4257.87226383209, 4266.616004559604, 4301.483821941387, 4333.696641235115, 4309.762963037032, 4309.892252693677, 4317.5466576009385, 4329.631981281564, 4358.716683415568, 4492.595666390008, 4634.652401069933, 4641.071785642851, 4665.300204969248, 4703.059388122355, 5114.744262786846, 5139.460356662534, 5180.197069454241, 5185.325907631984, 5193.584513238932, 5184.326037615086, 5198.6880787152895, 5223.73881305937, 5225.790968361261, 5239.0, 4572.0627271409285, 4692.4603670577635, 4695.483496815347, 4701.459332176775, 4777.761111944458, 5178.223266510054, 5206.817761378334, 5232.555232805178, 5234.13636749932, 5237.109691352479, 4805.543473370024, 4997.550220480174, 4999.475055119233, 5001.024800163933, 5002.049610573979, 4967.652264341534, 5002.674826136289, 5009.44896061433, 5011.398632164163, 5039.77321020555, 4976.4525902150735, 4994.625403094782, 4996.150654388763, 5006.499350065037, 5043.2435134730085, 4897.706137631682, 4958.181899986534, 4978.029284289529, 4991.725455100004, 5030.874228144253, 4292.506361768436, 4313.094250207429, 4320.481542214954, 4342.305231163062, 4374.868753937387, 3741.120836603396, 3757.6993840492696, 3771.8868433947027, 3798.0694729791376, 3809.2000679856988, 4235.195312890541, 4269.466316710411, 4345.065810850682, 4400.141972315368, 4412.0955204183065, 5105.719185444762, 5115.5396014358885, 5134.614903882224, 5141.485851414828, 5182.870428239325, 4411.911761764747, 4418.204723149864, 4419.248727716296, 4427.5351088135285, 4469.821207151743, 4548.13585418776, 4552.226121559343, 4557.316402539579, 4626.1210370029585, 4676.462206846256, 4808.591269741971, 4820.276958456259, 4828.058528586962, 4858.975705121523, 4861.319415281934, 5184.9740751296, 5196.298499702643, 5197.168453047494, 5200.45395233495, 5204.0892843752945, 4585.266357382803, 4602.7698615069785, 4617.884552886205, 4623.098495793288, 4857.781399837087, 4819.6867203633055, 4886.169351210374, 4890.828820991391, 4897.069556784199, 4942.925856112233, 4924.8768780780765, 4961.82633607822, 4969.304297398439, 4982.402111746469, 5019.548240658358, 4882.633802464758, 4925.1873440881855, 4957.603391728725, 4975.228839529878, 5021.72380519075, 4982.177940639754, 4986.0, 5010.048090862724, 5016.924746128738, 5053.67151135175, 4629.560191781776, 4896.926546101882, 4945.703257804544, 4950.702957822542, 4988.775505102207, 4865.854024379133, 4905.3623029006, 4910.754462276944, 4916.410030796327, 4918.655694101379, 4776.59398951093, 4788.521147885183, 4789.114013907439, 4796.472388037243, 4836.032793441396], "value": 4644.237244445143, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.9094135879617, 606.9726862291196, 614.5544480251816, 615.1725928625997, 616.069734700602, 28302.150935471942, 30919.0, 43208.13583728328, 44338.77830610851, 44352.556474435245, 43082.56917430825, 43452.34821477673, 43491.34762978558, 43518.12963740723, 43576.12847743043, 7848.999999999985, 7992.040955085398, 8001.1198768135455, 8002.399820013493, 8009.0, 7854.528728276293, 7980.3615710743, 7986.081600615946, 7987.321077708372, 7987.640556174957, 7992.601294773421, 8035.0, 8038.075621303537, 8043.517388956652, 8046.718364857231, 7917.0, 7979.441439099207, 7996.480228785111, 8005.879911801328, 8006.439549231585, 7861.21387861215, 7948.761537153837, 7964.362850971908, 7964.681412743484, 7966.5618390988475, 40051.198976020314, 40313.0, 40405.59594404048, 40448.19103617941, 40462.393064104064, 3441.913952151191, 3451.3269912366845, 3875.748076375055, 3973.940390894139, 3980.3631418972827, 30236.546451803242, 30274.54588181157, 30313.545296820565, 30488.390232195452, 30810.22974425635, 3335.232896433834, 3373.0, 3378.763486555942, 3478.7564870459078, 3495.0, 257725.0, 258026.0, 258463.0, 259533.0, 260639.0, 48498.0, 55412.445875540725, 55570.444295556525, 57083.0, 57271.41828653698, 59647.0, 59815.0, 59988.70005649944, 60024.0, 60058.39941600528, 15382.846171538142, 15556.922215389077, 15569.065856048674, 15569.922150389402, 15575.610609734847, 10329.018743219533, 11728.120390970711, 12016.33910134951, 12076.577319793765, 12160.939195303967, 16043.518694439186, 16104.194790260675, 16109.355625774837, 16173.838261617468, 16192.514224573282, 6218.1916350875, 6333.524985626004, 6354.809355719336, 6417.807465776034, 6491.9350806492275, 894.6466145872344, 979.0649929317485, 985.8126955878361, 1073.2862646340097, 1090.7327704712395, 29418.264543386587, 29545.85227073894, 29607.25981850471, 29968.0, 30071.09786706402, 997.3816233935007, 998.55065220651, 1043.446973104241, 1060.8726952765562, 1078.8219943709357, 15215.0, 15683.843161568466, 15692.76460853088, 15840.44558440449, 15965.68068638644, 366434.0, 368266.0, 370760.0, 371403.0, 371455.0, 53340.46659533355, 53513.46486535085, 53541.732291338296, 53568.73215633897, 53629.7318513405, 1183.4378670131618, 1286.2218357893528, 1303.3418123847396, 1316.8814806667447, 1323.2986517145928, 28650.28374290576, 30293.69706302997, 30506.84746576253, 30989.44551509278, 30999.535006975366, 43743.56256437395, 43889.78055109704, 44136.33795493006, 44155.77922110369, 44252.336214957446, 294557.0, 295472.0, 297824.0, 297925.0, 298416.0, 32447.837760811046, 33307.83346083254, 33472.0, 39190.80404597959, 39499.60500395074, 43566.34650480182, 43711.56288437075, 43897.0, 44352.11295774002, 44932.326015110455, 37201.4419783698, 37821.243575127795, 37929.241415172095, 38738.80630596829, 38879.41680874732, 37782.81108594439, 37904.810475947445, 38200.2359952805, 38315.61684383232, 38594.0, 36782.816085919396, 37347.62652373441, 37378.252434950606, 37617.81191094027, 37629.62370376261, 32260.677393225767, 33680.3263934715, 33715.0, 33939.15152121217, 34280.314393712484, 25739.356516087246, 26038.86980565085, 26139.607905881807, 26352.868235658698, 26438.735612643628], "value": 18328.629395512817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.677777111684, 375.47996025504676, 384.17977617786033, 391.11998004489897, 395.5609273706184, 16024.679506409879, 17676.204570794314, 18400.44798656039, 18446.35437759679, 18601.488799012128, 16584.668306633892, 16916.661666766657, 17132.400365987192, 17839.554011149696, 17862.642747145048, 5045.84862454127, 5188.792448302082, 5205.869853253661, 5222.7649755760895, 5231.293775340338, 3682.5028621136207, 3861.073342397832, 3958.9604103959023, 5936.228290322252, 5942.970285148568, 5863.179154918314, 5945.554083443737, 5949.67276799778, 5975.551833612496, 5994.040953447449, 5858.297004359461, 5881.294244690643, 5892.558058145656, 5968.492678122365, 5982.820515384546, 3357.8824741134185, 4933.605311575066, 5261.921071183935, 5268.762905669216, 5289.391719952217, 20561.69157462639, 20710.896445517676, 20935.26726564563, 21111.788882111137, 21155.894220528953, 1944.4944314478196, 1952.6192392483472, 1961.597872436147, 2174.956021109876, 2538.8984440622353, 13018.934905325414, 13279.601611951657, 13389.933050334783, 13547.45810167592, 13783.724325513534, 1758.1297257857314, 1813.156882049853, 1814.3559036542101, 1845.6677797996356, 1865.0767869904348, 68237.0, 70290.64854675745, 71390.64304678496, 71555.99999999948, 71638.28361716369, 9593.42439453635, 9701.52611084169, 9850.0, 10047.246456515644, 10196.38821670702, 13631.386587603582, 13688.93155534216, 13700.794488082687, 13738.244396558086, 13815.171089734647, 7483.139438964588, 7751.806204844924, 7777.533347999138, 7852.136265010844, 7882.448228623941, 7386.409087273113, 7562.054743157106, 7620.276073772982, 7667.616619169019, 7676.731314403969, 6368.936310636835, 6383.744650213939, 6444.420002199825, 6452.483801295885, 6464.159659244268, 1774.2636805725479, 1820.0808591661125, 1835.9541011474553, 1848.9753719676933, 1855.461916044359, 883.6288758721353, 922.4050487435701, 986.5609803637456, 1003.518311210623, 1030.0, 16122.0, 17010.82989170117, 17471.30114795394, 17519.824801752075, 17938.372156974445, 898.734873212404, 914.2457472585144, 931.6180366050022, 939.7838497145694, 962.9374090684083, 7664.885026724603, 9721.270904682036, 9833.213342932548, 9920.603175872884, 10031.0, 172961.0, 173957.0, 174277.0, 389742.0, 389749.0, 61305.63429429087, 84307.0, 85332.99999999876, 86634.13365866386, 90006.0, 915.455304094063, 985.9408435493893, 996.496769131584, 1001.5442973447064, 1005.6932635546083, 15823.367065317258, 15873.444429444913, 15995.520134395987, 16031.759523607388, 16109.758353624939, 36743.08142296464, 37376.813115934245, 37654.435183472815, 37834.0541486465, 38166.42750358803, 45056.324155138354, 47482.0, 51861.740691296305, 53575.0, 53945.730271348395, 7469.551826890404, 7544.698212071675, 7578.12851522082, 7720.845583088195, 7752.65113069902, 8480.194381533744, 11087.944560277147, 11486.885131148916, 11687.065034797026, 11833.349165795964, 9984.60061597557, 10615.150787936793, 10796.67609971702, 10817.459127043774, 11052.281601695864, 10813.891861081289, 10848.132149428184, 10901.236913415985, 10938.781224375627, 11140.275882067639, 10775.0, 11251.549938002388, 11273.71815704614, 11296.378699171624, 11340.319580825177, 7768.300852923264, 7866.252705992922, 7905.525668459911, 7955.641996110305, 8118.878216826634, 9258.35191536586, 10765.0, 10900.781984360427, 10983.340999540053, 11007.669769906915], "value": 8500.740039355802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.9012809496217, 1501.0243341827813, 1521.5283262188723, 1712.3578658003248, 1871.457277389557, 6573.70418331175, 7390.704371825127, 7586.165521792605, 7631.885521717179, 7852.489588176779, 7517.774466765992, 7689.538627682343, 7715.421343399254, 7721.30508254257, 7737.72917947872, 1876.7091100879318, 1942.359021522894, 1943.8250557449826, 2160.8595441296306, 2187.628103222448, 2145.0883374565824, 2204.669299605056, 2207.6798864164684, 2221.333599920026, 2227.721534808149, 2157.4282815054025, 2177.205320058183, 2189.419803752007, 2190.5290362572123, 2202.8678279303213, 1808.4213051823422, 2094.6962690409805, 2103.905324260404, 2133.957320853582, 2134.061013154207, 2181.3674034530127, 2217.3569664797187, 2220.9555808883733, 2223.9888800556055, 2224.177054489849, 7562.092548894113, 7662.693492260303, 7671.194524574895, 7684.961575192144, 7692.846143077163, 4356.912861742779, 4485.506594274627, 4493.056458143794, 4493.393391892086, 4495.0, 2584.8578328191943, 2670.4392077663715, 2773.861306934645, 2786.122371452986, 2788.5956536302324, 839.5130824121994, 892.7500299916034, 894.516960841145, 917.5824999625155, 937.0910217089412, 10157.339772914736, 10158.59365625374, 10162.59349626014, 10189.490525473771, 10191.89808101917, 4121.9381709274385, 4203.096334288142, 4268.445102136702, 4282.143571285756, 4307.396964424983, 8705.216530512283, 8763.824723505622, 8768.868466972874, 8775.780605484913, 8783.385163038525, 4553.977230113828, 4563.634909207255, 4564.589186973189, 4564.908701825945, 4565.0413413183605, 3668.816559172084, 3991.880243592697, 4098.959010409917, 4136.0, 4181.895452613709, 3605.675489205984, 3626.256617393428, 3684.1526448916898, 3696.2977034363385, 3735.7571757835653, 1167.4221260476118, 1186.6558697977662, 1190.2917763930448, 1194.0387987669835, 1197.9940100299443, 879.8636211387245, 898.1871406377239, 914.8848171974438, 918.136951265808, 920.4799288402031, 5304.230886521433, 5365.436629153961, 5387.784488620489, 5394.163904594794, 5447.346318441812, 396.2570180910792, 403.66697474583, 403.8364462392736, 407.5150570820773, 410.45614560707185, 3644.4168932970597, 3646.4165733483046, 3680.429533422324, 3703.333399988028, 3765.8681946131755, 8878.644854205888, 9275.72172834816, 9285.72142835716, 9301.069893010645, 9302.767430814283, 9282.582283797245, 9302.488363139957, 9337.066293370744, 9352.39209451397, 9352.906470935204, 7100.751473698396, 7144.714211431485, 7297.379722723628, 7299.708011679473, 7346.449016323797, 5229.607779416483, 5281.9471805281455, 5315.840524784263, 5350.892982140414, 5386.057439948072, 8641.481511109354, 8679.0, 8681.348898832486, 8773.56132193375, 8792.824143517222, 8536.103709110454, 8788.648454061766, 8822.029576746681, 8993.910060899307, 9015.594298256725, 5761.625494342854, 6277.18396608438, 6404.903926441014, 6551.279359270381, 6625.834354141185, 7319.158296795937, 7340.522866013692, 7381.8154546136775, 7411.444141689502, 7427.331540161412, 6512.316206798408, 6641.601503909781, 6673.065770791996, 6750.898736518858, 6820.7271709133065, 6499.512536559682, 6506.479481641362, 6554.246261679968, 6599.439047681001, 6599.769008084694, 6222.160008398808, 6252.374762523893, 6279.780207692709, 6285.0, 6285.59143655661, 4479.417675702138, 4596.4714057883775, 4652.488226295172, 4669.369635099218, 4693.178693728652, 4611.008633143891, 4630.328602352707, 4643.558861908248, 4695.178343789755, 4751.714897106184], "value": 4009.2285073285116, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.94151140527595, 308.19714643354064, 311.92981579144686, 316.1211831109516, 316.9492881139017, 4714.481407045227, 4753.595944344735, 4762.618990480762, 4775.641826862981, 4780.8565743027675, 4492.505824359326, 4573.216445586224, 4603.332516785064, 4633.305004249364, 4717.315989181567, 3662.963370366302, 3675.0628589709586, 3683.889483315505, 3755.3052685253315, 3784.280986612535, 3767.1523907120954, 3768.604296548864, 3784.526934133233, 3785.261873934584, 3811.4282857571447, 3652.068722475765, 3732.0, 3741.6632503074716, 3753.2681127180213, 3754.2116155607355, 3739.813009349549, 3763.2097259575385, 3766.9434958475645, 3775.8112094395447, 3775.9433608495897, 3349.246419555605, 3360.0, 3364.9158771030675, 3373.662633736631, 3384.561561336422, 4547.794834368895, 4557.544245575449, 4566.49768525462, 4571.9314210286875, 4574.382458368111, 3977.880663580097, 4188.832446702128, 4213.094184750294, 4297.5702429756775, 4313.741175529478, 4905.460399356068, 4929.162042452792, 4936.827211047596, 4943.8516844494725, 4954.331165292675, 3530.3645343838098, 3538.168530395355, 3542.9114272143147, 3547.396942519752, 3558.3417067842274, 5012.373453318335, 5139.738515053365, 5158.561522270612, 5199.986002729469, 5201.921971170397, 3594.388953877847, 3603.5675718913376, 3611.602723700391, 3617.620149884277, 3627.619099994515, 3678.6572900890983, 3682.9263414731554, 3684.299983003221, 3695.74129810916, 3699.7595156314756, 4228.936565951513, 4234.745915245096, 4239.724417912826, 4241.342591898199, 4248.235317642854, 4802.399700037496, 4909.440655524787, 4963.305137280783, 4968.180250258667, 4973.726445045485, 1229.9200551964093, 1230.7353918907477, 1231.4581584102966, 1237.3751255615857, 1239.727260002798, 799.6441583495405, 837.6712738586617, 859.1108203009854, 859.3168431097167, 864.8367945113812, 4273.9358909616385, 4287.2711639021445, 4288.23408901257, 4289.463817022872, 4292.025668192604, 4946.932901601031, 4966.304717339575, 4971.925421118686, 4978.850634480971, 4983.551480366712, 4050.736702114412, 4292.283086765319, 4292.313229883266, 4301.397804307337, 4315.352697095461, 2635.827056959635, 2640.1815437214523, 2644.59008853628, 2645.5634820254827, 2649.2449651849515, 4651.604613607881, 4655.162070827284, 4656.230632359681, 4658.604018658452, 4680.906381872343, 4897.0, 4967.006598680278, 5008.173651347487, 5023.6985780853265, 5275.973620131952, 4763.3807605011125, 4799.784009719501, 4800.279958006257, 4807.351007613997, 4830.686005409637, 5113.718745469035, 5125.615578831528, 5129.2819005340025, 5130.743462826918, 5161.81933632321, 4904.337914381513, 5044.720931394623, 5060.493950605058, 5063.240513922941, 5064.34163558735, 4720.952790472052, 4798.832040878552, 4837.274408838703, 4840.419149702058, 4845.95154048455, 3552.5789684126557, 3555.484454754098, 3557.8043207623828, 3581.838817253282, 3593.946090808692, 4884.682495637914, 5113.769880355468, 5116.692998420107, 5117.411497677815, 5136.152534831711, 4947.183714687037, 4968.627352948471, 4969.751512424436, 4990.130674861896, 4991.126552853309, 4980.676256043345, 4985.725785081855, 5000.1749711297225, 5000.524950129732, 5021.5229553192385, 4613.261878099488, 4672.6495512837355, 4932.8520144395725, 4956.826511072095, 4966.751662416937, 4875.609951203966, 4938.38270216223, 4947.678400903929, 4960.082384758687, 4981.37732783402, 4810.927836082532, 4847.587955023862, 4871.415430148405, 4884.267359895902, 4891.388576427947], "value": 3733.3183329544395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.8526324208674, 711.5837235217396, 764.9923500764991, 796.6295672512281, 803.9758807235785, 12393.0, 12450.501979920804, 12514.186577872431, 12520.874791252085, 12570.182938109028, 12692.93653531731, 12864.035197360188, 12919.547815826449, 12925.095243332948, 13032.739345213091, 690.3683129936103, 843.7004863273542, 863.8833757442727, 880.6829541365104, 881.3213825354474, 870.1820288928419, 877.6226222724226, 878.2139984713677, 878.4158534574532, 878.8813510176109, 909.6997990663099, 917.1516347378648, 918.673870775875, 918.8667643191733, 919.7240827751681, 717.7774889784183, 882.5895958379384, 907.2288554728494, 915.972520824373, 917.2845180758985, 674.3863084593046, 676.3946268090081, 676.9289224631441, 677.0453660338899, 677.2110491277656, 13134.146280491737, 13158.473661053642, 13164.0, 13182.538611148564, 13186.07697461178, 12328.383580821013, 12699.809502857464, 12720.109592328541, 12796.936015319958, 13115.344232788419, 10959.559226454357, 11124.944375278154, 11381.886181138165, 11408.543658253742, 11749.177557570973, 4187.644050255702, 4215.683823713233, 4229.6404805591255, 4369.3009118541195, 4369.584889435499, 45335.319970200144, 45644.315335269996, 45683.314750278776, 45761.31358029632, 45832.0, 10281.897181028244, 10304.124149447382, 10320.896791032144, 10327.122194613392, 10443.530041148166, 18209.635807284045, 19094.904525477283, 19123.90438047801, 19209.32767353164, 19231.230750769813, 6785.084013658192, 7034.472414568928, 7072.3634872861685, 7081.89377159343, 7201.96399018012, 3681.7238707097076, 3737.0844143185095, 3783.356829339019, 3906.882793516199, 3908.159745654641, 2901.956470652942, 3027.6366835979825, 3029.8485075746567, 3031.2876474028585, 3034.2262723005933, 530.885859540193, 531.4605675239635, 535.3495502963917, 540.3596737865641, 542.8561431220729, 528.5454509122152, 651.8533330000806, 655.4101308822003, 656.0945894665331, 671.1509939925998, 8244.464109832841, 8448.281896038905, 8456.154384561618, 8532.317414606816, 8688.174623410765, 607.3926073926074, 612.7059011674421, 633.2875515045574, 644.3197090679116, 648.0590631060005, 3780.1872597391693, 3788.3813729664694, 3812.9809350953624, 3868.864589739346, 4059.188162367538, 36836.0, 36913.0, 39916.0, 52574.0, 52806.471935280926, 48004.75997619989, 48190.0, 48428.0, 48525.757371212916, 49852.25221621679, 44094.0, 44108.3383749244, 44529.0, 44648.3302750459, 45244.0951180968, 7525.403735711171, 7664.156942736183, 7735.806604834924, 7756.689732410866, 7781.572013539309, 28525.714742852306, 28930.7106928928, 29421.26446838846, 29688.257793555335, 29868.70131298659, 36539.817300913324, 38956.2208755829, 39771.40342894801, 39913.401298981116, 40392.59607404006, 10448.0, 10500.219044963798, 10588.576456941637, 10688.41213733221, 10755.677329680122, 10349.84475232857, 10373.118284945864, 10953.288036277616, 11349.37578433161, 11544.82682759776, 10128.44293563861, 10165.0, 10250.436226007641, 10522.684319470429, 10696.89303106959, 10573.735656608646, 10644.84032739525, 11024.724381890517, 11125.165612578927, 11127.610533631285, 10444.373337599769, 10491.68524944253, 10590.947045264724, 10997.285176463503, 11020.228583999044, 9006.954965225132, 9007.09929007094, 9193.448393096436, 9214.121925753385, 9430.056994300516, 8743.693970710994, 8816.603252853509, 8869.246114080375, 9035.412698174861, 9362.438253704799], "value": 6100.156090518976, "unit": "score"}], "name": "dromaeo_css", "value": 6358.314929919411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 113.0, 113.0, 111.0, 115.0, 112.0, 114.0, 115.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 152.0, 196.0, 134.0, 156.0, 157.0, 136.0, 188.0, 132.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 124.0, 77.0, 75.0, 77.0, 74.0, 129.0, 76.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 116.0, 93.0, 93.0, 93.0, 126.0, 93.0, 93.0, 122.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 147.0, 145.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 81.0, 65.0, 64.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 65.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 82.0, 82.0, 85.0, 88.0, 84.0, 84.0, 84.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 143.0, 141.0, 130.0, 131.0, 139.0, 129.0, 189.0, 154.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 173.0, 172.0, 175.0, 174.0, 174.0, 171.0, 174.0, 170.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 75.0, 67.0, 67.0, 71.0, 70.0, 66.0, 66.0, 70.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1571.7000000000003, "alertThreshold": 2.0}]} 14:03:30 INFO - Return code: 0 14:03:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:03:30 ERROR - # TBPL SUCCESS # 14:03:30 INFO - Running post-action listener: _resource_record_post_action 14:03:30 INFO - ##### 14:03:30 INFO - ##### Finished run-tests step (success) 14:03:30 INFO - ##### 14:03:30 INFO - Running post-run listener: _resource_record_post_run 14:03:31 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518860800; Read time: 112; Write time: 356504 14:03:31 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 235098112; Read time: 76; Write time: 205216 14:03:31 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283762688; Read time: 36; Write time: 151288 14:03:31 INFO - Running post-run listener: _upload_blobber_files 14:03:31 INFO - Blob upload gear active. 14:03:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:03:31 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 14:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:03:31 INFO - (blobuploader) - INFO - Open directory for files ... 14:03:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:03:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:03:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:32 INFO - (blobuploader) - INFO - Done attempting. 14:03:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:03:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:03:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:33 INFO - (blobuploader) - INFO - Done attempting. 14:03:33 INFO - (blobuploader) - INFO - Iteration through files over. 14:03:33 INFO - Return code: 0 14:03:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:03:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:03:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33078477b2994e5f092a2ee00608ba4eda9ff9e7ddc7c87239dfd106a0ed32c2e7d49c1332ab256ae12d55525283d10e714be84da5fc9370a168c9462eb19e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f274d355484c22f96da9e839013a86f122f8f726adc60a781c51dff33077da712ccaa5305b34b89ca3e937a8d6b21a32205d9063041582504a7815d33f55c7d1"} 14:03:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:03:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:03:33 INFO - Contents: 14:03:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33078477b2994e5f092a2ee00608ba4eda9ff9e7ddc7c87239dfd106a0ed32c2e7d49c1332ab256ae12d55525283d10e714be84da5fc9370a168c9462eb19e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f274d355484c22f96da9e839013a86f122f8f726adc60a781c51dff33077da712ccaa5305b34b89ca3e937a8d6b21a32205d9063041582504a7815d33f55c7d1"} 14:03:33 INFO - Running post-run listener: copy_logs_to_upload_dir 14:03:33 INFO - Copying logs to upload dir... 14:03:33 INFO - mkdir: /builds/slave/test/build/upload/logs 14:03:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.971342 ========= master_lag: 150.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 6 secs) (at 2016-05-06 14:06:04.239038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-05-06 14:06:04.242863) ========= 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=00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33078477b2994e5f092a2ee00608ba4eda9ff9e7ddc7c87239dfd106a0ed32c2e7d49c1332ab256ae12d55525283d10e714be84da5fc9370a168c9462eb19e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f274d355484c22f96da9e839013a86f122f8f726adc60a781c51dff33077da712ccaa5305b34b89ca3e937a8d6b21a32205d9063041582504a7815d33f55c7d1"} build_url:https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/CFMHi7rERda5CB7Wyvdv6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33078477b2994e5f092a2ee00608ba4eda9ff9e7ddc7c87239dfd106a0ed32c2e7d49c1332ab256ae12d55525283d10e714be84da5fc9370a168c9462eb19e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f274d355484c22f96da9e839013a86f122f8f726adc60a781c51dff33077da712ccaa5305b34b89ca3e937a8d6b21a32205d9063041582504a7815d33f55c7d1"}' ========= master_lag: 4.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-05-06 14:06:08.532009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 14:06:08.532341) ========= 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=00204705a9daa57ed339a427000001b9-1462567373.916137-1512483382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 14:06:08.733195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 14:06:08.733499) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 14:06:09.618578) ========= ========= Total master_lag: 155.28 =========