builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1461506645.86 results: success (0) buildid: 20160424060542 builduid: 8de3696ac7b7480b933cdf34af9052b7 revision: 463fc6d36ff561f17a34f1688bd8c38833de8966 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:05.864667) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:05.865665) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:05.866359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:05.909247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:05.909953) ========= 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=ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 07:04:06-- 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% 230M=0s 2016-04-24 07:04:06 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179236 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.132067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.132595) ========= 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=ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014014 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.182446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.182807) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 463fc6d36ff561f17a34f1688bd8c38833de8966 --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 463fc6d36ff561f17a34f1688bd8c38833de8966 --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=ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 07:04:06,479 truncating revision to first 12 chars 2016-04-24 07:04:06,479 Setting DEBUG logging. 2016-04-24 07:04:06,479 attempt 1/10 2016-04-24 07:04:06,479 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/463fc6d36ff5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 07:04:06,836 unpacking tar archive at: fx-team-463fc6d36ff5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.853327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.853677) ========= script_repo_revision: 463fc6d36ff561f17a34f1688bd8c38833de8966 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.854184) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.854546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 07:04:06.866095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-24 07:04:06.866381) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:04:07 INFO - MultiFileLogger online at 20160424 07:04:07 in /builds/slave/test 07:04:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 07:04:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:04:07 INFO - {'append_to_log': False, 07:04:07 INFO - 'base_work_dir': '/builds/slave/test', 07:04:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:04:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:04:07 INFO - 'branch': 'Fx-Team-Non-PGO', 07:04:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:04:07 INFO - 'config_files': ('talos/linux_config.py',), 07:04:07 INFO - 'default_actions': ('clobber', 07:04:07 INFO - 'read-buildbot-config', 07:04:07 INFO - 'download-and-extract', 07:04:07 INFO - 'populate-webroot', 07:04:07 INFO - 'create-virtualenv', 07:04:07 INFO - 'install', 07:04:07 INFO - 'run-tests'), 07:04:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:04:07 INFO - 'download_minidump_stackwalk': True, 07:04:07 INFO - 'download_symbols': 'ondemand', 07:04:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:04:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:04:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:04:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:04:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:04:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:04:07 INFO - 'installer_path': 'installer.exe', 07:04:07 INFO - 'log_level': 'info', 07:04:07 INFO - 'log_name': 'talos', 07:04:07 INFO - 'log_to_console': True, 07:04:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:04:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:04:07 INFO - 'opt_config_files': (), 07:04:07 INFO - 'pip_index': False, 07:04:07 INFO - 'sps_profile': False, 07:04:07 INFO - 'sps_profile_interval': 0, 07:04:07 INFO - 'suite': 'dromaeojs-e10s', 07:04:07 INFO - 'system_bits': '32', 07:04:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:04:07 INFO - 'title': 'talos-linux64-ix-035', 07:04:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:04:07 INFO - 'use_talos_json': True, 07:04:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:04:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:04:07 INFO - 'work_dir': 'build'} 07:04:07 INFO - ##### 07:04:07 INFO - ##### Running clobber step. 07:04:07 INFO - ##### 07:04:07 INFO - Running pre-action listener: _resource_record_pre_action 07:04:07 INFO - Running main action method: clobber 07:04:07 INFO - rmtree: /builds/slave/test/build 07:04:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:04:07 INFO - Running post-action listener: _resource_record_post_action 07:04:07 INFO - ##### 07:04:07 INFO - ##### Running read-buildbot-config step. 07:04:07 INFO - ##### 07:04:07 INFO - Running pre-action listener: _resource_record_pre_action 07:04:07 INFO - Running main action method: read_buildbot_config 07:04:07 INFO - Using buildbot properties: 07:04:07 INFO - { 07:04:07 INFO - "project": "", 07:04:07 INFO - "product": "firefox", 07:04:07 INFO - "script_repo_revision": "production", 07:04:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:04:07 INFO - "repository": "", 07:04:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:04:07 INFO - "buildid": "20160424060542", 07:04:07 INFO - "pgo_build": "False", 07:04:07 INFO - "basedir": "/builds/slave/test", 07:04:07 INFO - "buildnumber": 1200, 07:04:07 INFO - "slavename": "talos-linux64-ix-035", 07:04:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:04:07 INFO - "platform": "ubuntu64_hw", 07:04:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:04:07 INFO - "branch": "fx-team", 07:04:07 INFO - "repo_path": "integration/fx-team", 07:04:07 INFO - "revision": "463fc6d36ff561f17a34f1688bd8c38833de8966", 07:04:07 INFO - "stage_platform": "linux64", 07:04:07 INFO - "builduid": "8de3696ac7b7480b933cdf34af9052b7", 07:04:07 INFO - "slavebuilddir": "test" 07:04:07 INFO - } 07:04:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:04:07 INFO - Running post-action listener: _resource_record_post_action 07:04:07 INFO - ##### 07:04:07 INFO - ##### Running download-and-extract step. 07:04:07 INFO - ##### 07:04:07 INFO - Running pre-action listener: _resource_record_pre_action 07:04:07 INFO - Running main action method: download_and_extract 07:04:07 INFO - mkdir: /builds/slave/test/build/tests 07:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:07 INFO - https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:04:17 INFO - Downloaded 1361 bytes. 07:04:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:04:17 INFO - Using the following test package requirements: 07:04:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:04:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:04:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:04:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:17 INFO - u'jsshell-linux-x86_64.zip'], 07:04:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:04:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:04:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:04:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:04:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:04:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:04:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:04:17 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')]} 07:04:17 INFO - https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:04:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:04:33 INFO - Downloaded 22285608 bytes. 07:04:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:04:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:04:34 INFO - Return code: 0 07:04:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:34 INFO - https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:04:36 INFO - Downloaded 22285608 bytes. 07:04:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:04:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:04:37 INFO - Return code: 0 07:04:37 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')]} 07:04:37 INFO - https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:04:38 INFO - Downloaded 10840145 bytes. 07:04:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:04:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:04:38 INFO - Return code: 0 07:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:38 INFO - https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:04:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:04:40 INFO - Downloaded 54730109 bytes. 07:04:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:40 INFO - mkdir: /builds/slave/test/properties 07:04:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:04:40 INFO - Writing to file /builds/slave/test/properties/build_url 07:04:40 INFO - Contents: 07:04:40 INFO - build_url:https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:04:40 INFO - Running post-action listener: _resource_record_post_action 07:04:40 INFO - Running post-action listener: set_extra_try_arguments 07:04:40 INFO - ##### 07:04:40 INFO - ##### Running populate-webroot step. 07:04:40 INFO - ##### 07:04:40 INFO - Running pre-action listener: _resource_record_pre_action 07:04:40 INFO - Running main action method: populate_webroot 07:04:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:04:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:04:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:04:40 INFO - '--tppagecycles', 07:04:40 INFO - '7'], 07:04:40 INFO - 'tests': ['tsvgm']}}, 07:04:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:04:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:04:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:04:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:04:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:04:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:04:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:40 INFO - 'talos_options': ['--disable-e10s'], 07:04:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:04:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:04:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:40 INFO - 'talos_options': ['--disable-e10s'], 07:04:40 INFO - 'tests': ['damp', 'tps']}, 07:04:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:40 INFO - 'tests': ['damp', 'tps']}, 07:04:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:04:40 INFO - 'tests': ['dromaeo_dom']}, 07:04:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:04:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:04:40 INFO - 'tests': ['a11yr', 07:04:40 INFO - 'ts_paint', 07:04:40 INFO - 'tpaint', 07:04:40 INFO - 'sessionrestore', 07:04:40 INFO - 'sessionrestore_no_auto_restore', 07:04:40 INFO - 'tabpaint']}, 07:04:40 INFO - 'other-e10s': {'tests': ['a11yr', 07:04:40 INFO - 'ts_paint', 07:04:40 INFO - 'tpaint', 07:04:40 INFO - 'sessionrestore', 07:04:40 INFO - 'sessionrestore_no_auto_restore', 07:04:40 INFO - 'tabpaint']}, 07:04:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:04:41 INFO - 'ts_paint', 07:04:41 INFO - 'tpaint', 07:04:41 INFO - 'sessionrestore', 07:04:41 INFO - 'sessionrestore_no_auto_restore', 07:04:41 INFO - 'tabpaint']}, 07:04:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:04:41 INFO - 'ts_paint', 07:04:41 INFO - 'tpaint', 07:04:41 INFO - 'sessionrestore', 07:04:41 INFO - 'sessionrestore_no_auto_restore', 07:04:41 INFO - 'tabpaint']}, 07:04:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:04:41 INFO - 'tests': ['a11yr', 07:04:41 INFO - 'ts_paint', 07:04:41 INFO - 'tpaint', 07:04:41 INFO - 'sessionrestore', 07:04:41 INFO - 'sessionrestore_no_auto_restore', 07:04:41 INFO - 'tabpaint']}, 07:04:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:04:41 INFO - 'tests': ['a11yr', 07:04:41 INFO - 'ts_paint', 07:04:41 INFO - 'tpaint', 07:04:41 INFO - 'sessionrestore', 07:04:41 INFO - 'sessionrestore_no_auto_restore', 07:04:41 INFO - 'tabpaint']}, 07:04:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:04:41 INFO - 'tests': ['tsvgx', 07:04:41 INFO - 'tsvgr_opacity', 07:04:41 INFO - 'tart', 07:04:41 INFO - 'tscrollx', 07:04:41 INFO - 'cart']}, 07:04:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:04:41 INFO - 'tsvgr_opacity', 07:04:41 INFO - 'tart', 07:04:41 INFO - 'tscrollx', 07:04:41 INFO - 'cart']}, 07:04:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:41 INFO - 'talos_options': ['--disable-e10s'], 07:04:41 INFO - 'tests': ['tp5o']}, 07:04:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:41 INFO - 'tests': ['tp5o']}, 07:04:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:41 INFO - 'talos_options': ['--disable-e10s', 07:04:41 INFO - '--xperf_path', 07:04:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:04:41 INFO - 'tests': ['tp5n']}, 07:04:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:04:41 INFO - 'talos_options': ['--xperf_path', 07:04:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:04:41 INFO - 'tests': ['tp5n']}}, 07:04:41 INFO - 'talos.zip': {'path': '', 07:04:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:04:41 INFO - Running post-action listener: _resource_record_post_action 07:04:41 INFO - ##### 07:04:41 INFO - ##### Running create-virtualenv step. 07:04:41 INFO - ##### 07:04:41 INFO - Running pre-action listener: _resource_record_pre_action 07:04:41 INFO - Running main action method: create_virtualenv 07:04:41 INFO - Creating virtualenv /builds/slave/test/build/venv 07:04:41 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 07:04:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:04:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:04:41 INFO - Using real prefix '/usr' 07:04:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:04:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:04:43 INFO - Installing pip.................done. 07:04:43 INFO - Return code: 0 07:04:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:43 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 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:04:43 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 07:04:43 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 07:04:43 INFO - Using env: {'DISPLAY': ':0', 07:04:43 INFO - 'HOME': '/home/cltbld', 07:04:43 INFO - 'LANG': 'en_US.UTF-8', 07:04:43 INFO - 'LANGUAGE': 'en_US:en', 07:04:43 INFO - 'LOGNAME': 'cltbld', 07:04:43 INFO - 'MAIL': '/var/mail/cltbld', 07:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:43 INFO - 'MOZ_NO_REMOTE': '1', 07:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:43 INFO - 'NO_EM_RESTART': '1', 07:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:43 INFO - 'PWD': '/builds/slave/test', 07:04:43 INFO - 'SHELL': '/bin/bash', 07:04:43 INFO - 'SHLVL': '1', 07:04:43 INFO - 'TERM': 'linux', 07:04:43 INFO - 'TMOUT': '86400', 07:04:43 INFO - 'USER': 'cltbld', 07:04:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:43 INFO - '_': '/tools/buildbot/bin/python'} 07:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:44 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 07:04:44 INFO - Cleaning up... 07:04:44 INFO - Return code: 0 07:04:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:44 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 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:04:44 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 07:04:44 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 07:04:44 INFO - Using env: {'DISPLAY': ':0', 07:04:44 INFO - 'HOME': '/home/cltbld', 07:04:44 INFO - 'LANG': 'en_US.UTF-8', 07:04:44 INFO - 'LANGUAGE': 'en_US:en', 07:04:44 INFO - 'LOGNAME': 'cltbld', 07:04:44 INFO - 'MAIL': '/var/mail/cltbld', 07:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:44 INFO - 'MOZ_NO_REMOTE': '1', 07:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:44 INFO - 'NO_EM_RESTART': '1', 07:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:44 INFO - 'PWD': '/builds/slave/test', 07:04:44 INFO - 'SHELL': '/bin/bash', 07:04:44 INFO - 'SHLVL': '1', 07:04:44 INFO - 'TERM': 'linux', 07:04:44 INFO - 'TMOUT': '86400', 07:04:44 INFO - 'USER': 'cltbld', 07:04:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:44 INFO - '_': '/tools/buildbot/bin/python'} 07:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:44 INFO - Downloading/unpacking psutil>=0.7.1 07:04:44 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 07:04:44 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 07:04:44 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 07:04:44 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 07:04:44 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 07:04:44 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 07:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:04:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:46 INFO - Installing collected packages: psutil 07:04:46 INFO - Running setup.py install for psutil 07:04:46 INFO - building 'psutil._psutil_linux' extension 07:04:46 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 07:04:48 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 07:04:48 INFO - building 'psutil._psutil_posix' extension 07:04:48 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 07:04:48 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 07:04:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:48 INFO - Successfully installed psutil 07:04:48 INFO - Cleaning up... 07:04:49 INFO - Return code: 0 07:04:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:49 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 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:04:49 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 07:04:49 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 07:04:49 INFO - Using env: {'DISPLAY': ':0', 07:04:49 INFO - 'HOME': '/home/cltbld', 07:04:49 INFO - 'LANG': 'en_US.UTF-8', 07:04:49 INFO - 'LANGUAGE': 'en_US:en', 07:04:49 INFO - 'LOGNAME': 'cltbld', 07:04:49 INFO - 'MAIL': '/var/mail/cltbld', 07:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:49 INFO - 'MOZ_NO_REMOTE': '1', 07:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:49 INFO - 'NO_EM_RESTART': '1', 07:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:49 INFO - 'PWD': '/builds/slave/test', 07:04:49 INFO - 'SHELL': '/bin/bash', 07:04:49 INFO - 'SHLVL': '1', 07:04:49 INFO - 'TERM': 'linux', 07:04:49 INFO - 'TMOUT': '86400', 07:04:49 INFO - 'USER': 'cltbld', 07:04:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:49 INFO - '_': '/tools/buildbot/bin/python'} 07:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:04:51 INFO - Installing collected packages: mozsystemmonitor 07:04:51 INFO - Running setup.py install for mozsystemmonitor 07:04:51 INFO - Successfully installed mozsystemmonitor 07:04:51 INFO - Cleaning up... 07:04:51 INFO - Return code: 0 07:04:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:04:51 INFO - Using env: {'DISPLAY': ':0', 07:04:51 INFO - 'HOME': '/home/cltbld', 07:04:51 INFO - 'LANG': 'en_US.UTF-8', 07:04:51 INFO - 'LANGUAGE': 'en_US:en', 07:04:51 INFO - 'LOGNAME': 'cltbld', 07:04:51 INFO - 'MAIL': '/var/mail/cltbld', 07:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:51 INFO - 'MOZ_NO_REMOTE': '1', 07:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:51 INFO - 'NO_EM_RESTART': '1', 07:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:51 INFO - 'PWD': '/builds/slave/test', 07:04:51 INFO - 'SHELL': '/bin/bash', 07:04:51 INFO - 'SHLVL': '1', 07:04:51 INFO - 'TERM': 'linux', 07:04:51 INFO - 'TMOUT': '86400', 07:04:51 INFO - 'USER': 'cltbld', 07:04:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:51 INFO - '_': '/tools/buildbot/bin/python'} 07:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:51 INFO - Downloading/unpacking blobuploader==1.2.4 07:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:53 INFO - Downloading blobuploader-1.2.4.tar.gz 07:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:04:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:04:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:54 INFO - Downloading docopt-0.6.1.tar.gz 07:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:04:54 INFO - Installing collected packages: blobuploader, requests, docopt 07:04:54 INFO - Running setup.py install for blobuploader 07:04:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:04:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:04:54 INFO - Running setup.py install for requests 07:04:54 INFO - Running setup.py install for docopt 07:04:54 INFO - Successfully installed blobuploader requests docopt 07:04:54 INFO - Cleaning up... 07:04:54 INFO - Return code: 0 07:04:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:54 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')]} 07:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:54 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')]} 07:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:54 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 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:04:54 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 07:04:54 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 07:04:54 INFO - Using env: {'DISPLAY': ':0', 07:04:54 INFO - 'HOME': '/home/cltbld', 07:04:54 INFO - 'LANG': 'en_US.UTF-8', 07:04:54 INFO - 'LANGUAGE': 'en_US:en', 07:04:54 INFO - 'LOGNAME': 'cltbld', 07:04:54 INFO - 'MAIL': '/var/mail/cltbld', 07:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:54 INFO - 'MOZ_NO_REMOTE': '1', 07:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:54 INFO - 'NO_EM_RESTART': '1', 07:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:54 INFO - 'PWD': '/builds/slave/test', 07:04:54 INFO - 'SHELL': '/bin/bash', 07:04:54 INFO - 'SHLVL': '1', 07:04:54 INFO - 'TERM': 'linux', 07:04:54 INFO - 'TMOUT': '86400', 07:04:54 INFO - 'USER': 'cltbld', 07:04:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:54 INFO - '_': '/tools/buildbot/bin/python'} 07:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:54 INFO - Running setup.py (path:/tmp/pip-HIHwG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:55 INFO - Running setup.py (path:/tmp/pip-_gVhf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:55 INFO - Running setup.py (path:/tmp/pip-ThK5O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:55 INFO - Running setup.py (path:/tmp/pip-kgTBZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:55 INFO - Running setup.py (path:/tmp/pip-B2Dy62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:55 INFO - Running setup.py (path:/tmp/pip-XUfpkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:55 INFO - Running setup.py (path:/tmp/pip-lfTaUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:55 INFO - Running setup.py (path:/tmp/pip-tgAq0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:55 INFO - Running setup.py (path:/tmp/pip-R_8TNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:55 INFO - Running setup.py (path:/tmp/pip-YH2waF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:55 INFO - Running setup.py (path:/tmp/pip-YpV55r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:55 INFO - Running setup.py (path:/tmp/pip-NDQx30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:55 INFO - Running setup.py (path:/tmp/pip-U3aJco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:55 INFO - Running setup.py (path:/tmp/pip-7go9MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:55 INFO - Running setup.py (path:/tmp/pip-QQ5M6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:56 INFO - Running setup.py (path:/tmp/pip-liLgAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:56 INFO - Running setup.py (path:/tmp/pip-t7ajb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:04:56 INFO - Running setup.py install for manifestparser 07:04:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:04:56 INFO - Running setup.py install for mozcrash 07:04:56 INFO - Running setup.py install for mozdebug 07:04:56 INFO - Running setup.py install for mozdevice 07:04:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:04:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:04:56 INFO - Running setup.py install for mozfile 07:04:56 INFO - Running setup.py install for mozhttpd 07:04:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:04:56 INFO - Running setup.py install for mozinfo 07:04:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:04:56 INFO - Running setup.py install for mozInstall 07:04:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:04:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:04:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:04:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:04:57 INFO - Running setup.py install for mozleak 07:04:57 INFO - Running setup.py install for mozlog 07:04:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:04:57 INFO - Running setup.py install for moznetwork 07:04:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:04:57 INFO - Running setup.py install for mozprocess 07:04:57 INFO - Running setup.py install for mozprofile 07:04:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:04:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:04:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:04:57 INFO - Running setup.py install for mozrunner 07:04:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:04:57 INFO - Running setup.py install for mozscreenshot 07:04:57 INFO - Running setup.py install for moztest 07:04:57 INFO - Running setup.py install for mozversion 07:04:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:04:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:04:57 INFO - Cleaning up... 07:04:57 INFO - Return code: 0 07:04:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:57 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 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:04:57 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 07:04:58 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 07:04:58 INFO - Using env: {'DISPLAY': ':0', 07:04:58 INFO - 'HOME': '/home/cltbld', 07:04:58 INFO - 'LANG': 'en_US.UTF-8', 07:04:58 INFO - 'LANGUAGE': 'en_US:en', 07:04:58 INFO - 'LOGNAME': 'cltbld', 07:04:58 INFO - 'MAIL': '/var/mail/cltbld', 07:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:58 INFO - 'MOZ_NO_REMOTE': '1', 07:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:58 INFO - 'NO_EM_RESTART': '1', 07:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:58 INFO - 'PWD': '/builds/slave/test', 07:04:58 INFO - 'SHELL': '/bin/bash', 07:04:58 INFO - 'SHLVL': '1', 07:04:58 INFO - 'TERM': 'linux', 07:04:58 INFO - 'TMOUT': '86400', 07:04:58 INFO - 'USER': 'cltbld', 07:04:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:58 INFO - '_': '/tools/buildbot/bin/python'} 07:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:58 INFO - Running setup.py (path:/tmp/pip-YQDswu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:58 INFO - Running setup.py (path:/tmp/pip-_USWLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:58 INFO - Running setup.py (path:/tmp/pip-QucXJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:58 INFO - Running setup.py (path:/tmp/pip-Pcj7M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:58 INFO - Running setup.py (path:/tmp/pip-DigOzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:58 INFO - Running setup.py (path:/tmp/pip-Dg_EBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:58 INFO - Running setup.py (path:/tmp/pip-mo_XV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:58 INFO - Running setup.py (path:/tmp/pip-7pUyOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:58 INFO - Running setup.py (path:/tmp/pip-YLkqgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:58 INFO - Running setup.py (path:/tmp/pip-b1Vyh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:58 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)) 07:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:58 INFO - Running setup.py (path:/tmp/pip-QlJE8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:59 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)) 07:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:59 INFO - Running setup.py (path:/tmp/pip-M3ed5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:59 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)) 07:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:59 INFO - Running setup.py (path:/tmp/pip-nRdeO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:59 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)) 07:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:59 INFO - Running setup.py (path:/tmp/pip-v7Mj5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:59 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)) 07:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:59 INFO - Running setup.py (path:/tmp/pip-IzM2tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:59 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)) 07:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:59 INFO - Running setup.py (path:/tmp/pip-qufDX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:59 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)) 07:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:59 INFO - Running setup.py (path:/tmp/pip-G3pAAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:59 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)) 07:04:59 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)) 07:04:59 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)) 07:04:59 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)) 07:04:59 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)) 07:04:59 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)) 07:04:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:59 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 07:04:59 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 07:04:59 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 07:04:59 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 07:04:59 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 07:04:59 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 07:05:01 INFO - Downloading blessings-1.6.tar.gz 07:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:05:01 INFO - Installing collected packages: blessings 07:05:01 INFO - Running setup.py install for blessings 07:05:01 INFO - Successfully installed blessings 07:05:01 INFO - Cleaning up... 07:05:01 INFO - Return code: 0 07:05:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:05:01 INFO - Reading from file tmpfile_stdout 07:05:01 INFO - Current package versions: 07:05:01 INFO - argparse == 1.2.1 07:05:01 INFO - blessings == 1.6 07:05:01 INFO - blobuploader == 1.2.4 07:05:01 INFO - docopt == 0.6.1 07:05:01 INFO - manifestparser == 1.1 07:05:01 INFO - mozInstall == 1.12 07:05:01 INFO - mozcrash == 0.17 07:05:01 INFO - mozdebug == 0.1 07:05:01 INFO - mozdevice == 0.48 07:05:01 INFO - mozfile == 1.2 07:05:01 INFO - mozhttpd == 0.7 07:05:01 INFO - mozinfo == 0.9 07:05:01 INFO - mozleak == 0.1 07:05:01 INFO - mozlog == 3.1 07:05:01 INFO - moznetwork == 0.27 07:05:01 INFO - mozprocess == 0.22 07:05:01 INFO - mozprofile == 0.28 07:05:01 INFO - mozrunner == 6.11 07:05:01 INFO - mozscreenshot == 0.1 07:05:01 INFO - mozsystemmonitor == 0.0 07:05:01 INFO - moztest == 0.7 07:05:01 INFO - mozversion == 1.4 07:05:01 INFO - psutil == 3.1.1 07:05:01 INFO - requests == 1.2.3 07:05:01 INFO - wsgiref == 0.1.2 07:05:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:01 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 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:05:01 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 07:05:01 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 07:05:01 INFO - Using env: {'DISPLAY': ':0', 07:05:01 INFO - 'HOME': '/home/cltbld', 07:05:01 INFO - 'LANG': 'en_US.UTF-8', 07:05:01 INFO - 'LANGUAGE': 'en_US:en', 07:05:01 INFO - 'LOGNAME': 'cltbld', 07:05:01 INFO - 'MAIL': '/var/mail/cltbld', 07:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:01 INFO - 'MOZ_NO_REMOTE': '1', 07:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:01 INFO - 'NO_EM_RESTART': '1', 07:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:01 INFO - 'PWD': '/builds/slave/test', 07:05:01 INFO - 'SHELL': '/bin/bash', 07:05:01 INFO - 'SHLVL': '1', 07:05:01 INFO - 'TERM': 'linux', 07:05:01 INFO - 'TMOUT': '86400', 07:05:01 INFO - 'USER': 'cltbld', 07:05:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:01 INFO - '_': '/tools/buildbot/bin/python'} 07:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 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)) 07:05:01 INFO - Cleaning up... 07:05:01 INFO - Return code: 0 07:05:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:05:02 INFO - Using env: {'DISPLAY': ':0', 07:05:02 INFO - 'HOME': '/home/cltbld', 07:05:02 INFO - 'LANG': 'en_US.UTF-8', 07:05:02 INFO - 'LANGUAGE': 'en_US:en', 07:05:02 INFO - 'LOGNAME': 'cltbld', 07:05:02 INFO - 'MAIL': '/var/mail/cltbld', 07:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:02 INFO - 'MOZ_NO_REMOTE': '1', 07:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:02 INFO - 'NO_EM_RESTART': '1', 07:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:02 INFO - 'PWD': '/builds/slave/test', 07:05:02 INFO - 'SHELL': '/bin/bash', 07:05:02 INFO - 'SHLVL': '1', 07:05:02 INFO - 'TERM': 'linux', 07:05:02 INFO - 'TMOUT': '86400', 07:05:02 INFO - 'USER': 'cltbld', 07:05:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:02 INFO - '_': '/tools/buildbot/bin/python'} 07:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:02 INFO - Downloading/unpacking jsonschema 07:05:02 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 07:05:02 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 07:05:02 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 07:05:02 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 07:05:02 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 07:05:02 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 07:05:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:05:04 INFO - Downloading/unpacking functools32 (from jsonschema) 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:04 INFO - Downloading functools32-3.2.3-2.tar.gz 07:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:05:04 INFO - warning: no files found matching '*.txt' 07:05:04 INFO - no previously-included directories found matching 'build' 07:05:04 INFO - no previously-included directories found matching 'dist' 07:05:04 INFO - no previously-included directories found matching '.git*' 07:05:04 INFO - Installing collected packages: jsonschema, functools32 07:05:04 INFO - Running setup.py install for functools32 07:05:04 INFO - warning: no files found matching '*.txt' 07:05:04 INFO - no previously-included directories found matching 'build' 07:05:04 INFO - no previously-included directories found matching 'dist' 07:05:04 INFO - no previously-included directories found matching '.git*' 07:05:04 INFO - Successfully installed jsonschema functools32 07:05:04 INFO - Cleaning up... 07:05:04 INFO - Return code: 0 07:05:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f22c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', '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 07:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:05:04 INFO - Using env: {'DISPLAY': ':0', 07:05:04 INFO - 'HOME': '/home/cltbld', 07:05:04 INFO - 'LANG': 'en_US.UTF-8', 07:05:04 INFO - 'LANGUAGE': 'en_US:en', 07:05:04 INFO - 'LOGNAME': 'cltbld', 07:05:04 INFO - 'MAIL': '/var/mail/cltbld', 07:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:04 INFO - 'MOZ_NO_REMOTE': '1', 07:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:04 INFO - 'NO_EM_RESTART': '1', 07:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:04 INFO - 'PWD': '/builds/slave/test', 07:05:04 INFO - 'SHELL': '/bin/bash', 07:05:04 INFO - 'SHLVL': '1', 07:05:04 INFO - 'TERM': 'linux', 07:05:04 INFO - 'TMOUT': '86400', 07:05:04 INFO - 'USER': 'cltbld', 07:05:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:04 INFO - '_': '/tools/buildbot/bin/python'} 07:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:04 INFO - Downloading/unpacking flake8 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:05:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:05:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:05:07 INFO - no previously-included directories found matching 'docs/_build' 07:05:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:05:07 INFO - Running setup.py install for pep8 07:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:05:07 INFO - no previously-included directories found matching 'docs/_build' 07:05:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:05:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:05:07 INFO - Cleaning up... 07:05:07 INFO - Return code: 0 07:05:07 INFO - Running post-action listener: _resource_record_post_action 07:05:07 INFO - Running post-action listener: _start_resource_monitoring 07:05:07 INFO - Starting resource monitoring. 07:05:07 INFO - ##### 07:05:07 INFO - ##### Running install step. 07:05:07 INFO - ##### 07:05:07 INFO - Running pre-action listener: _resource_record_pre_action 07:05:07 INFO - Running main action method: install 07:05:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:05:08 INFO - Reading from file tmpfile_stdout 07:05:08 INFO - Detecting whether we're running mozinstall >=1.0... 07:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:05:08 INFO - Reading from file tmpfile_stdout 07:05:08 INFO - Output received: 07:05:08 INFO - Usage: mozinstall [options] installer 07:05:08 INFO - Options: 07:05:08 INFO - -h, --help show this help message and exit 07:05:08 INFO - -d DEST, --destination=DEST 07:05:08 INFO - Directory to install application into. [default: 07:05:08 INFO - "/builds/slave/test"] 07:05:08 INFO - --app=APP Application being installed. [default: firefox] 07:05:08 INFO - mkdir: /builds/slave/test/build/application 07:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:05:23 INFO - Reading from file tmpfile_stdout 07:05:23 INFO - Output received: 07:05:23 INFO - /builds/slave/test/build/application/firefox/firefox 07:05:23 INFO - Running post-action listener: _resource_record_post_action 07:05:23 INFO - ##### 07:05:23 INFO - ##### Running run-tests step. 07:05:23 INFO - ##### 07:05:23 INFO - Running pre-action listener: _resource_record_pre_action 07:05:23 INFO - Running main action method: run_tests 07:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:05:23 INFO - Python 2.7.3 07:05:23 INFO - Return code: 0 07:05:23 INFO - grabbing minidump binary from tooltool 07:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:23 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 0x2c48410>, '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 0x2c49310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c497a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:05:23 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 07:05:23 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 07:05:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:05:23 INFO - Return code: 0 07:05:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:05:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:05:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:05:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:05:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:05:24 INFO - Return code: 0 07:05:24 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:05:24 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:05:24 INFO - Using env: {'DISPLAY': ':0', 07:05:24 INFO - 'HOME': '/home/cltbld', 07:05:24 INFO - 'LANG': 'en_US.UTF-8', 07:05:24 INFO - 'LANGUAGE': 'en_US:en', 07:05:24 INFO - 'LOGNAME': 'cltbld', 07:05:24 INFO - 'MAIL': '/var/mail/cltbld', 07:05:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:05:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:24 INFO - 'MOZ_NO_REMOTE': '1', 07:05:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:24 INFO - 'NO_EM_RESTART': '1', 07:05:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:24 INFO - 'PWD': '/builds/slave/test', 07:05:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:05:24 INFO - 'SHELL': '/bin/bash', 07:05:24 INFO - 'SHLVL': '1', 07:05:24 INFO - 'TERM': 'linux', 07:05:24 INFO - 'TMOUT': '86400', 07:05:24 INFO - 'USER': 'cltbld', 07:05:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506', 07:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:24 INFO - '_': '/tools/buildbot/bin/python'} 07:05:24 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:05:25 INFO - mozversion application_buildid: 20160424060542 07:05:25 INFO - mozversion application_changeset: 463fc6d36ff561f17a34f1688bd8c38833de8966 07:05:25 INFO - mozversion application_display_name: Nightly 07:05:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:05:25 INFO - mozversion application_name: Firefox 07:05:25 INFO - mozversion application_remotingname: firefox 07:05:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:05:25 INFO - mozversion application_vendor: Mozilla 07:05:25 INFO - mozversion application_version: 48.0a1 07:05:25 INFO - mozversion platform_buildid: 20160424060542 07:05:25 INFO - mozversion platform_changeset: 463fc6d36ff561f17a34f1688bd8c38833de8966 07:05:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:05:25 INFO - mozversion platform_version: 48.0a1 07:05:25 INFO - using testdate: 1461506725 07:05:25 INFO - actual date: 1461506725 07:05:25 INFO - starting webserver on 'localhost:36870' 07:05:25 INFO - SUITE-START | Running 2 tests 07:05:25 INFO - TEST-START | dromaeo_css 07:05:25 INFO - operating with platform_type : linux_ 07:05:25 INFO - Initialising browser for dromaeo_css test... 07:05:25 INFO - TEST-INFO | started process 3411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkSCdS_/profile http://localhost:36870/getInfo.html) 07:05:30 INFO - PROCESS | 3411 | 07:05:30 INFO - PROCESS | 3411 | (process:3480): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:05:31 INFO - PROCESS | 3411 | __metrics Screen width/height:1600/1200 07:05:31 INFO - PROCESS | 3411 | colorDepth:24 07:05:31 INFO - PROCESS | 3411 | Browser inner width/height: 1024/697 07:05:31 INFO - PROCESS | 3411 | __metrics 07:05:31 ERROR - PROCESS | 3411 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:05:32 INFO - TEST-INFO | 3411: exit 0 07:05:32 INFO - Browser initialized. 07:05:32 INFO - Running cycle 1/1 for dromaeo_css test... 07:05:32 INFO - TEST-INFO | started process 3531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkSCdS_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:05:34 INFO - PROCESS | 3531 | 07:05:34 INFO - PROCESS | 3531 | (process:3592): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:05:44 INFO - PROCESS | 3531 | RSS: Main: 166199296 07:05:44 INFO - PROCESS | 3531 | 07:06:34 INFO - PROCESS | 3531 | 1461506794027 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] 07:08:45 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:36870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36870/tests/dromaeo/cssquery-ext.html) 07:08:46 INFO - PROCESS | 3531 | RSS: Main: 170049536 07:08:46 INFO - PROCESS | 3531 | 07:11:48 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:36870/tests/dromaeo/cssquery-ext.html (next: http://localhost:36870/tests/dromaeo/cssquery-jquery.html) 07:11:49 INFO - PROCESS | 3531 | RSS: Main: 167579648 07:11:49 INFO - PROCESS | 3531 | 07:14:51 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:36870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36870/tests/dromaeo/cssquery-mootools.html) 07:14:51 INFO - PROCESS | 3531 | RSS: Main: 168345600 07:14:51 INFO - PROCESS | 3531 | 07:17:53 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:36870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36870/tests/dromaeo/cssquery-prototype.html) 07:17:54 INFO - PROCESS | 3531 | RSS: Main: 165974016 07:17:54 INFO - PROCESS | 3531 | 07:20:57 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:36870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36870/tests/dromaeo/cssquery-yui.html) 07:20:57 INFO - PROCESS | 3531 | RSS: Main: 166481920 07:20:57 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:36870/tests/dromaeo/cssquery-yui.html (next: http://localhost:36870/tests/dromaeo/cssquery-dojo.html) 07:24:00 INFO - PROCESS | 3531 | RSS: Main: 168448000 07:24:00 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | __start_tp_report 07:24:00 INFO - PROCESS | 3531 | _x_x_mozilla_page_load 07:24:00 INFO - PROCESS | 3531 | _x_x_mozilla_page_load_details 07:24:00 INFO - PROCESS | 3531 | |i|pagename|runs| 07:24:00 INFO - PROCESS | 3531 | |0;dojo.html;2625.356787587041;2643.8810253538595;2712.0914493644627;2743.87652555635;2744.8627568621578;4735.928961065587;4784.425868895729;4803.039392121572;4817.951820481794;4850.3694519712435;4661.790219440125;4745.667803253774;4808.99011207646;4842.830500932468;4876.390451193601;4368.104538569602;4425.800838962238;4507.053518761048;4522.5025247222775;4543.182227199103;488.9334997400232;4319.330503771905;4337.154254920292;4343.804528796211;4392.275274579706;4346.022145017361;4351.782410879443;4362.302031674949;4363.738175709467;4416.492103408117;4345.9130817383475;4353.673474489426;4356.194104090721;4393.494748103945;4416.712913660634;4338.327559228324;4400.7579583122915;4408.647308215335;4428.623566996777;4458.754768487732;4698.318743782167;4704.858854234379;4752.857414277577;4758.595519380857;4763.261694437368;5025.14572522672;5090.770915308783;5179.663321884065;5185.896282074337;5226.843194704127;5186.559142472895;5224.4775522447835;5238.5809135269465;5241.135212689902;5282.894342113136;4832.106060378841;4861.440934292566;4861.586765125004;4883.536064073907;4895.192293271606;5214.530692237717;5254.92117618236;5294.655847369909;5320.388155362106;5358.11591087474;5032.823851165192;5037.143685573461;5037.5214354636255;5073.898522029539;5124.154514505065;5152.510511501401;5159.896802063938;5170.40540337866;5182.870428239249;5191.454897235812;4973.900521989613;5119.360079990001;5135.3324067870935;5188.792448302102;5220.634555581149;5106.15748401517;5114.43741188469;5118.820841270538;5124.7950081996305;5129.333186685782;4424.867253982386;4427.158839820424;4429.224885645;4435.223835828717;4477.261251893467;3732.1789206375097;3762.266358060152;3785.280796648628;3882.1653344530496;3948.7433316834313;4402.647788176938;4415.183191109655;4462.286034234572;4485.708428952108;4496.033352829158;5180.352455943007;5194.454582268883;5195.090859099642;5206.375234971828;5207.7916883325;4275.4441922550495;4444.711093778894;4481.327800829901;4512.097580483916;4517.841875534341;4560.68075234737;4622.34314567579;4625.930611040837;4631.722096674143;4669.2062349400685;4806.062817750505;4812.181929072136;4827.106985207748;4827.710337379768;4863.3434486344595;5098.796048158032;5165.044466773659;5226.581873450191;5258.421573626822;5263.499967503081;4808.855734327975;4810.254410566367;4830.541098595628;4830.830920917751;4878.048780487771;4967.552920237196;5032.119379108568;5033.5721463676;5058.443571207091;5067.695938243717;5152.27868098459;5213.218017297436;5220.791168353375;5254.290670759551;5286.735663216747;4937.629677774109;4943.456219815889;4944.629152813482;4954.3311652926395;5020.974895125501;4856.320115183807;4878.63410244226;4949.950500495093;4954.380702412199;4961.950380496149;4969.975150124226;4980.9501904981935;4988.4263309719845;5001.224810154432;5043.394792624908;5083.694978301313;5084.211947148198;5119.180931051014;5127.102757017582;5162;4776.665633405628;4856.39295088114;4962.751862406937;5008.298838162587;5023.045621331935 07:24:00 INFO - PROCESS | 3531 | |1;ext.html;567.3588844605595;605.7576969212314;612.7579606055606;623.4762799248632;641.9935800641993;34789;36113.81943090281;36132.1094312455;36179.27641447169;36208.27583448329;39069.65582065078;39660.40509392361;39662;39798.80100599493;39940.80029599848;7718.2281771822645;7846.882296765553;7859.174786647377;7896.842063158733;7908.406869484783;7734.226577342249;7819.452638315321;7824.921750782476;7844.68621255152;7846.764597062097;7832.843343133134;7855.371570274365;7869.173736757644;7908.367330613537;7928.524288542706;7765.53406795594;7831.2560306770765;7865.17415671352;7868.291853733192;7871.724489642864;7793.688252469894;7864.606769661551;7896;7903.762887113396;7931.167227441151;29710.40579188404;36884.81557592221;37323.06692332686;37396;37420.625793742256;3030.636323641177;3094.6930384304005;3110.0669799060192;3670.247599242149;3914.64768170866;25093.121740738985;25127.497450050898;25856.353591160183;25915.22254332373;26126.085587004553;3138.7802853800245;3144.5912031435996;3173.76196785242;3187.729043031345;3199.6480387157394;185240;186179;186961;187453;188393;32356.35287294241;32553.51169732456;32581.18547036343;32584.348313033606;33751.32497350039;32241.838790805898;32434;32484.837575812442;32675;32675.509867352008;11784;12045.15683902136;12098.637040888787;12113.939430302793;12137.089718271165;10497.422641754623;10714;10728.839067413996;10737;10741.301815381976;8095.757127286191;8108.351331893435;8168.305694016075;8275.255227029596;8293.419460637697;3217.2761128746315;3234.1429521176906;3246.6753324667343;3280.801862751962;3297.7196938260035;927;1031.3038698878227;1032.4166845732138;1048.171944164102;1086.4241951765578;28369.574456383172;28433.28916777097;28484.287892802433;28530.857345713554;28791.856040720082;1014.1886490807325;1048.4810019040472;1057.49768859791;1101.493313075978;1142.4230763464398;14729.779053314209;14936.551903442914;14968.75468679685;15254.389824406899;15451.690966180613;369889;375725;377913;378401;380017;47311;48172.27741583879;48358;48460.757696212;48538.75730621395;1231.1012960538858;1232.3345393487596;1236.3014896583582;1257.3147634539198;1277.0932637827061;26378.34054148585;27391.589126163522;27531;27699.89200432041;27931.441371172055;43162.56837431585;43425.56574434342;43734;43856.56143438525;43908.78045609751;330844;331926;332279;333628;334366;24010.759892400853;24241.151559695325;24251.63622545628;24291.271261862174;24302.270931872074;43633.781831090644;43804;44570;44594.108117838114;44683.32975005443;31788.523172151974;32474.512882307255;33006;33136.834315829234;33474.33051338911;34023.82988085044;34038.48942265918;34289.828550857084;34297.65702342945;34634.13414664553;34947.825260873535;35139.29721405506;37002.44496332503;37879.43180852234;37907;29929.551056734603;30701.385972279983;31336.304230530746;31825.68174318227;31895.68104318927;24372.146974856503;24377.14679986192;24379.756202437748;24690.876545617877;24943.87528062348 07:24:00 INFO - PROCESS | 3531 | |2;jquery.html;363.9818009099544;366.748777087695;379.538860284754;386.3798603241798;395.46414608205885;15914.204289785508;16182.514524564267;16391.344346226168;16459.506214813544;17036.659266814688;16327.83672163278;16552.420665276717;17209.13954302283;17296.30814767411;17362.56593585161;5087.872803179922;5240.764165612538;5241.187615919539;5271.5782737381105;5275.868103297429;3762.868299609514;5145.897082058356;5889;6214.254289485268;6220.6267623942485;6120.969395153018;6150.169727086831;6153.0155175171985;6173.81478555644;6177.969110154443;6660.100886380349;7022.508424410294;7026.191987921404;7102.14774227096;7104.431645468376;6599.736010559572;6837.555558888656;6895.275996020446;6919.100516932817;6935.133108361455;22409.43976400603;22452.88773556138;23573.88213058941;24244.515109697706;24496.387590310384;1924.7401600783855;2058.372196480073;2094.5810837832496;2118.6080575093656;2122.373899699592;13710.657233569142;13870;14121.576352709435;14494.202818844959;15193.392264309414;1625.2929975460595;1875.5873707784265;1920.1374666573402;1921.567647279365;1973.9111739971593;79631.20368796354;80893;81539.59230203812;81687.5915620424;83194;16631.91684041596;16783.412580559623;17059;17075.743863842054;17335.133243337783;29704.40591188164;29859;29881.252968675955;29929.251768705955;29949.401011979637;7952.32405245549;8148.388870834711;8260.917390826135;8276.172382761795;8294.668213271521;6548.508861835381;6566.6388348641285;6654.23476300222;6678.565893216925;6768.72925083001;8380.748577542683;8443.324534037261;8494.787630309293;8520.659173633108;8524.786880327918;1847.8152184781684;1924.970140974572;1944.8152425519554;1991.73111629931;3446.5174875516946;872.6334939325499;927.2535608834818;935.2331088507494;940.9294302927308;941.7692665296909;16007.919960400124;16131.838681613033;16353.918230408772;16509.83490165083;16831.831681683027;874.7069731639845;876.7632739160391;879.5426378283257;922.1516205091332;972.7811242470387;9387.812243755086;9474.905250947402;9506.33455658111;9516.809663806685;9525.952370238105;388073;395605;395961;398064;404105;75630.62184689041;80607.59696201599;82161.17838821655;82169.17830821735;83262;951.1059603972244;962.7448726087592;970.6602689058773;977.1010670183448;978.8433850584015;14696.853031469976;14798.852011479747;15062.322195501449;15115.395384184509;15427.074375537504;33299.83350083234;33606.32787344288;34334;35006.64993350136;35239;46781;46807.53192468168;49216.50783492119;49312;49929.251061234834;7532.8493430132185;7722.111957125003;7725.845483090419;7750.496217745828;7757.573333466714;7824.139344671968;9226.630934762534;10675.89324106749;10840.891591083988;10918.23572349928;9829.213662906806;9874.605015799574;10005.649802256887;10044.488877780555;10110.69667909964;9361.765955851159;9374.156325930426;9443.905560944577;9514.33399662017;9981.750456238653;9783.217342612432;10182.694519164437;10250.128739057263;10254.077133058061;10255.794884102126;7559.395248380007;7588.81027974305;7592.772216833504;7622.161562228262;7665.770026899202;8924.68763593271;9465.148136667733;9533.332666713264;9586.328956973224;9801.754956126153 07:24:00 INFO - PROCESS | 3531 | |3;mootools.html;1454.7599646058397;1487.0259979713287;1627.5768300241934;1744.6772347115777;1809.692352300109;6968.860622787542;7591.0890693116835;7602.087749470057;7880.921190788091;7903.407244456667;7609.353204977583;7616.124145723244;7651.1583725790115;7693.846123077535;7706.6146692665425;2208.05053826854;2211.6019116559014;2230.7434645015787;2238.608243557379;2243.170027089979;2188.245055455873;2226.0539270809923;2228.487447886987;2233.1737257214854;2234.452559123017;2196.890155492219;2217.1020736601704;2217.3347995601334;2222.355516900105;2244;2126.8192203662707;2160.1899287767087;2165.85921915075;2175.7062796522423;2177.0203408466255;2232.888355582231;2236.4408897775556;2253.966190507144;2257.6274914639066;2261.502469456717;7765.223477652246;7813.140554538996;7857.882131768028;7866.921330786676;7887.487313324616;4546.545345465427;4679.181143299943;4692.859214223578;4703.670743047988;4716.174669432836;2987.357718090599;3049.9085027449214;3058.831764252965;3059.5563643271603;3080.86136123875;912.0833562269943;932.8181004704086;954.6706386296717;955.1737746848995;972.4651441707103;10730;10791.190660700478;10805.621803236927;10839.241253112206;10905.34567925927;4314.848980285675;4323.459567554056;4505.909881802346;4513.54864513546;4550.294704320836;9181.58682859273;9194.678186263582;9219;9231.35380523357;9236.399634023766;4788.449328327218;4821.349117869043;4845.830395936126;4865.172920603506;4868;3813.866514671973;4077.89805254871;4179.6029377209115;4374.518802931675;4381.277089280296;3730.4963829882618;3756.1924186300075;3819.8854034379015;3841.654251117413;3930.803459827054;1230.39095647655;1261.5080118753694;1275.3623188405797;1278.8273583066166;1285.2417073926242;752.9397648188132;887.2414085956543;910.5128756115447;921.2169655792522;934.9953250233841;5627.634203776742;5658.434156584391;5668.801591944262;5745.2818397700285;5938.049912014057;845.2055068235961;854.3421565394611;891.5007595746403;947.0907928388687;964.4647220792527;3840.5967373425947;3951.664108550748;3991.261616600938;4022.8390864365683;4038.353863381845;8802.691905783267;8816.206541411175;9017.684381046633;9078.591463384164;9125.041870603623;9231.492267925194;9288.907110928803;9289.581968811419;9314.161725444743;9330.440173589606;7275.599842008634;7301.123865136217;7375.04124463827;7382.18795932447;7397.593132377663;5558.082916318762;5574.136008918624;5578.721063946868;5595.944040559542;5731.426857314235;8989.46063236208;9004.41471304363;9081.409708368936;9121;9133.315001375056;8688.609012594323;8953.92552893657;8964.775880603038;9033.187013168847;9065.32010099232;6511.892978193624;7140.821479463055;7255.709771609077;7414.962925185555;7447.478676492594;7472.514286571355;7486.700531978878;7489.513181643176;7503.362214211853;7555.320021198118;6465.288818229897;6600.808486611132;6657.101291325609;6663.800085997428;6743.561668491532;6419.871602567829;6476.579022363531;6716.899246511209;6800.965995169992;6803.557768745214;6529.347065293433;6623.271440141484;6624.105745724266;6653.168353955755;6658.067870498037;4261.126469073894;4784.162771515041;4867.29424233477;4889.755512224446;4895.608351331956;4887.120318342732;4951.5048495150195;5023.7488125592845;5026.095302845523;5030.4718004608985 07:24:00 INFO - PROCESS | 3531 | |4;prototype.html;309.236186619051;318.05061890257576;319.9248176678479;321.5787318612617;330.70071585215373;5413.756380962856;5467.9453205467935;5469.495888630624;5482.451754824516;5516.862078448041;5370.43610420906;5377.542908852753;5378.838634840961;5381.919271210925;5394.352677678674;3943.132510847609;4041.1513582147636;4162.209180255742;4163.479565054368;4172.457580514544;4183.602557757008;4198.181354635847;4206.516250631171;4219.683523735716;4223.957760422402;4176.582341765814;4179.770112643803;4188.392683060954;4188.413622092894;4197.244495990721;4105.240530501852;4169.708120431571;4175.828569144028;4183.163367326531;4190.874273771792;3660.4509323601405;3661.3775658137915;3668.853245870162;3672.926541469182;3673.6326367363317;5173.094708426048;5198.714070726109;5214.765335559909;5215.947840521622;5221.112410890158;4738.123447162252;4825.517448255181;4835.564799168056;4861.124997500448;4875.658703890729;5674.546036317085;5676.829695109112;5705.457981491793;5739.885202295931;5750.712464376765;4036.253293140749;4044.5753195914594;4047.5024241030715;4055.5741647127215;4058.1883623275166;5779.884402311972;5980.880382392371;5997.311653333212;6018.398160183947;6054.757809687607;4212.957870421256;4213.599708027732;4220;4225.366195070703;4246.936295955563;4296.10013241061;4307.289297265916;4308.332208507686;4312.331588603772;4313.525512193656;4595.655325850575;4841.201201801734;4856.174450343379;4860.80556777732;4888.653446345774;5750.568707346965;5761.222234998306;5764.942350576524;5783;5799.652020878761;1451.7894905238682;1465.230753854235;1477.2023107522032;1482.3107255126417;1484.834404992076;934.2432629569934;970.0784254957819;997.9800403991879;1006.3257617396362;1007.4912169354429;4845.75771211445;4883;4893.828715994923;4897.363342765489;4906.362172917497;5842.474177323977;5868.325142608569;5870.559708021916;5876.706164691748;5891.882162356729;4769.332293478916;4822.791819943806;4861.149298872683;4892;4921.50784921505;3148.291634382246;3163.114327988167;3174.0477856642915;3175.3490534440384;3181.8886338978486;5432.402435732066;5452.563794896478;5463.289772329651;5472.069748142825;5474.562035037187;5868.559858010581;5991.400859914061;6004.427365717478;6019.939800602026;6025.457708806229;5418.160185171305;5446.836594902159;5469.234307196995;5476.561875050066;5478.178273259043;5673.404292549223;5822;5856.297244330707;5864.208331875142;5877.94122058774;5660.37735849048;5667.829965101054;5675.148727690879;5680.318361796611;5687.829365119053;5410.702411367412;5420.2140689599;5425.267588875451;5461.361591522448;5470.179473078911;4106.733062350938;4138.172365526846;4176.7076304658385;4196;4267.615914567704;5808.21589085485;5809.883802324014;5838.912416313844;5867.295924489089;5870.178175055581;5631.690257035739;5669.688167150846;5673.602847800615;5680.857978550569;5690.800821971211;5444.3194600674915;5583.3708089741995;5647.519960803378;5658.349289831722;5671.376148623731;5435.320584926884;5511.834644960658;5581.693006884498;5581.916271255853;5587.664740115606;5614.410486898817;5806.419358064329;5841.269841269841;5847.970760146172;5858.326292476419;5638.774449021993;5669.81712040859;5687.3459552152035;5687.5449964001955;5699.088145896637 07:24:00 INFO - PROCESS | 3531 | |5;yui.html;743.475849526084;757.2427572427572;760.410681721666;770.7918861907285;775.3951917504348;12257;12673.302968336739;12830.871691283097;12842.678933026678;12845;12082.275063496174;12096.455659495321;12745.362731863415;12907.225566465995;12929.482820687184;644.8549076457806;781.4295564238109;812.9105798362175;824.2087595907935;828.2918105020211;817.1746535998625;817.3175398542224;818.7993941484344;819.3445243804962;820.24127681894;854.0647990450447;854.692310768126;857.2670366836359;857.9656813727444;859.3039637893295;848.240824462106;854.0647990450447;855.9614817333235;856.618804631939;857.5755001274377;624.073251221935;626.1859582542722;626.589583822597;629.2197674883158;631.4601016131188;11816;11873.406329683568;11875.703107422383;11891.821622675667;11907.821382679267;13029.413676384585;13109.213447193199;13150;13232.603021909357;13288.800667989988;9958.850617240747;10211.438370889598;10351.896481035168;10358.792824143475;10527.684169474927;3336.466165413522;3369.949450758241;3406.5401170842115;3409.8295085245886;3423.640517745626;47776.28335574934;48387.51612483901;48823.51176488225;48910.510894890955;49100.263496047584;9229;9388.62445502186;9909.256805739598;10188.319879539074;10193.592256309665;17142.40001599938;17195.398161064302;17203.741943870602;17225.39711110105;17250.65498690019;7114.786556403316;7149.714011439588;7162.856742865113;7181.174164970991;7415.8146046349275;3848.3650197717625;3891.1828516011956;3896.103896103912;3973.7019723520852;3998.420229066769;2839.1766387747734;2867.842268675201;2873.281679580105;3117.828519431453;3267.5752152220534;590.8759160576327;596.7463827873137;600.7987324246426;601.3385276196236;602.1148911100674;615.8614311779813;619.2166908860295;627.5168120547245;654.3946849164504;659.643792352134;8055.275025247756;8395.202455766692;8428.704995325257;8795.604197810986;8829.38194326391;595.7021489255372;602.9457348838538;604.9395060493915;627.7928283666379;629.2920464477463;3623.7825730456257;3706.8887933362043;3900.1224724436775;3920.6079392061138;3981.5421226559315;42623.36064959028;44823.103537929055;45080.54919450829;45191.774041130244;45317.54682453133;40484.79757601193;46082.53917460849;46818.06363872772;47716;47933.52066479361;41615;41872;41877.79061104675;41985.370219447344;42061.36907946383;7420.628968551443;7723.845523089619;7781.144074151725;7820.257075577811;7974.441789074941;27403.31491712723;28021.299467513476;28354.85822570874;28656.14031579056;28973.565396518647;34303.4854477178;37492.62507374891;37562.81218593889;37732;37779;9770.853437198306;9810.411375317504;9865.210783137189;9884.752881178028;9996.400215987063;10295;10405.895941040493;10504.317219380715;10840.620578280037;10984.780304394028;9872.851907221253;9973.650922217688;10062.899371006197;10152.289339746147;10249.590016399261;9700.854487182556;9967.40195588238;10025.849612255968;10033.74915627086;10508.211884108876;9931.851022234529;9965.701028969142;10003.249756268455;10270.794584108426;10330.690079297332;8693.652253909773;8779.517126558101;8980.955095224743;9022.368434209542;9527.57125929321;8401.747947561584;8467.78830529217;8510.361722870686;8581.184787445183;8618.698345557876 07:24:00 INFO - PROCESS | 3531 | __end_tp_report 07:24:00 INFO - PROCESS | 3531 | __start_cc_report 07:24:00 INFO - PROCESS | 3531 | _x_x_mozilla_cycle_collect,371 07:24:00 INFO - PROCESS | 3531 | __end_cc_report 07:24:00 INFO - PROCESS | 3531 | __startTimestamp1461507840570__endTimestamp 07:24:00 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | ------- Summary: start ------- 07:24:00 INFO - PROCESS | 3531 | Number of tests: 6 07:24:00 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | [#0] dojo.html Cycles:165 Average:4734.50 Median:4863.34 stddev:603.90 (12.4%) stddev-sans-first:582.64 07:24:00 INFO - PROCESS | 3531 | Values: 2625.4 2643.9 2712.1 2743.9 2744.9 4735.9 4784.4 4803.0 4818.0 4850.4 4661.8 4745.7 4809.0 4842.8 4876.4 4368.1 4425.8 4507.1 4522.5 4543.2 488.9 4319.3 4337.2 4343.8 4392.3 4346.0 4351.8 4362.3 4363.7 4416.5 4345.9 4353.7 4356.2 4393.5 4416.7 4338.3 4400.8 4408.6 4428.6 4458.8 4698.3 4704.9 4752.9 4758.6 4763.3 5025.1 5090.8 5179.7 5185.9 5226.8 5186.6 5224.5 5238.6 5241.1 5282.9 4832.1 4861.4 4861.6 4883.5 4895.2 5214.5 5254.9 5294.7 5320.4 5358.1 5032.8 5037.1 5037.5 5073.9 5124.2 5152.5 5159.9 5170.4 5182.9 5191.5 4973.9 5119.4 5135.3 5188.8 5220.6 5106.2 5114.4 5118.8 5124.8 5129.3 4424.9 4427.2 4429.2 4435.2 4477.3 3732.2 3762.3 3785.3 3882.2 3948.7 4402.6 4415.2 4462.3 4485.7 4496.0 5180.4 5194.5 5195.1 5206.4 5207.8 4275.4 4444.7 4481.3 4512.1 4517.8 4560.7 4622.3 4625.9 4631.7 4669.2 4806.1 4812.2 4827.1 4827.7 4863.3 5098.8 5165.0 5226.6 5258.4 5263.5 4808.9 4810.3 4830.5 4830.8 4878.0 4967.6 5032.1 5033.6 5058.4 5067.7 5152.3 5213.2 5220.8 5254.3 5286.7 4937.6 4943.5 4944.6 4954.3 5021.0 4856.3 4878.6 4950.0 4954.4 4962.0 4970.0 4981.0 4988.4 5001.2 5043.4 5083.7 5084.2 5119.2 5127.1 5162.0 4776.7 4856.4 4962.8 5008.3 5023.0 07:24:00 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | [#1] ext.html Cycles:180 Average:43678.81 Median:181990.42 stddev:81854.23 (45.0%) stddev-sans-first:82019.85 07:24:00 INFO - PROCESS | 3531 | Values: 567.4 605.8 612.8 623.5 642.0 34789.0 36113.8 36132.1 36179.3 36208.3 39069.7 39660.4 39662.0 39798.8 39940.8 7718.2 7846.9 7859.2 7896.8 7908.4 7734.2 7819.5 7824.9 7844.7 7846.8 7832.8 7855.4 7869.2 7908.4 7928.5 7765.5 7831.3 7865.2 7868.3 7871.7 7793.7 7864.6 7896.0 7903.8 7931.2 29710.4 36884.8 37323.1 37396.0 37420.6 3030.6 3094.7 3110.1 3670.2 3914.6 25093.1 25127.5 25856.4 25915.2 26126.1 3138.8 3144.6 3173.8 3187.7 3199.6 185240.0 186179.0 186961.0 187453.0 188393.0 32356.4 32553.5 32581.2 32584.3 33751.3 32241.8 32434.0 32484.8 32675.0 32675.5 11784.0 12045.2 12098.6 12113.9 12137.1 10497.4 10714.0 10728.8 10737.0 10741.3 8095.8 8108.4 8168.3 8275.3 8293.4 3217.3 3234.1 3246.7 3280.8 3297.7 927.0 1031.3 1032.4 1048.2 1086.4 28369.6 28433.3 28484.3 28530.9 28791.9 1014.2 1048.5 1057.5 1101.5 1142.4 14729.8 14936.6 14968.8 15254.4 15451.7 369889.0 375725.0 377913.0 378401.0 380017.0 47311.0 48172.3 48358.0 48460.8 48538.8 1231.1 1232.3 1236.3 1257.3 1277.1 26378.3 27391.6 27531.0 27699.9 27931.4 43162.6 43425.6 43734.0 43856.6 43908.8 330844.0 331926.0 332279.0 333628.0 334366.0 24010.8 24241.2 24251.6 24291.3 24302.3 43633.8 43804.0 44570.0 44594.1 44683.3 31788.5 32474.5 33006.0 33136.8 33474.3 34023.8 34038.5 34289.8 34297.7 34634.1 34947.8 35139.3 37002.4 37879.4 37907.0 29929.6 30701.4 31336.3 31825.7 31895.7 24372.1 24377.1 24379.8 24690.9 24943.9 07:24:00 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | [#2] jquery.html Cycles:180 Average:25766.45 Median:5273.72 stddev:65580.83 (1243.5%) stddev-sans-first:65737.07 07:24:00 INFO - PROCESS | 3531 | Values: 364.0 366.7 379.5 386.4 395.5 15914.2 16182.5 16391.3 16459.5 17036.7 16327.8 16552.4 17209.1 17296.3 17362.6 5087.9 5240.8 5241.2 5271.6 5275.9 3762.9 5145.9 5889.0 6214.3 6220.6 6121.0 6150.2 6153.0 6173.8 6178.0 6660.1 7022.5 7026.2 7102.1 7104.4 6599.7 6837.6 6895.3 6919.1 6935.1 22409.4 22452.9 23573.9 24244.5 24496.4 1924.7 2058.4 2094.6 2118.6 2122.4 13710.7 13870.0 14121.6 14494.2 15193.4 1625.3 1875.6 1920.1 1921.6 1973.9 79631.2 80893.0 81539.6 81687.6 83194.0 16631.9 16783.4 17059.0 17075.7 17335.1 29704.4 29859.0 29881.3 29929.3 29949.4 7952.3 8148.4 8260.9 8276.2 8294.7 6548.5 6566.6 6654.2 6678.6 6768.7 8380.7 8443.3 8494.8 8520.7 8524.8 1847.8 1925.0 1944.8 1991.7 3446.5 872.6 927.3 935.2 940.9 941.8 16007.9 16131.8 16353.9 16509.8 16831.8 874.7 876.8 879.5 922.2 972.8 9387.8 9474.9 9506.3 9516.8 9526.0 388073.0 395605.0 395961.0 398064.0 404105.0 75630.6 80607.6 82161.2 82169.2 83262.0 951.1 962.7 970.7 977.1 978.8 14696.9 14798.9 15062.3 15115.4 15427.1 33299.8 33606.3 34334.0 35006.6 35239.0 46781.0 46807.5 49216.5 49312.0 49929.3 7532.8 7722.1 7725.8 7750.5 7757.6 7824.1 9226.6 10675.9 10840.9 10918.2 9829.2 9874.6 10005.6 10044.5 10110.7 9361.8 9374.2 9443.9 9514.3 9981.8 9783.2 10182.7 10250.1 10254.1 10255.8 7559.4 7588.8 7592.8 7622.2 7665.8 8924.7 9465.1 9533.3 9586.3 9801.8 07:24:00 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | [#3] mootools.html Cycles:180 Average:5221.23 Median:5663.62 stddev:2823.40 (49.9%) stddev-sans-first:2817.14 07:24:00 INFO - PROCESS | 3531 | Values: 1454.8 1487.0 1627.6 1744.7 1809.7 6968.9 7591.1 7602.1 7880.9 7903.4 7609.4 7616.1 7651.2 7693.8 7706.6 2208.1 2211.6 2230.7 2238.6 2243.2 2188.2 2226.1 2228.5 2233.2 2234.5 2196.9 2217.1 2217.3 2222.4 2244.0 2126.8 2160.2 2165.9 2175.7 2177.0 2232.9 2236.4 2254.0 2257.6 2261.5 7765.2 7813.1 7857.9 7866.9 7887.5 4546.5 4679.2 4692.9 4703.7 4716.2 2987.4 3049.9 3058.8 3059.6 3080.9 912.1 932.8 954.7 955.2 972.5 10730.0 10791.2 10805.6 10839.2 10905.3 4314.8 4323.5 4505.9 4513.5 4550.3 9181.6 9194.7 9219.0 9231.4 9236.4 4788.4 4821.3 4845.8 4865.2 4868.0 3813.9 4077.9 4179.6 4374.5 4381.3 3730.5 3756.2 3819.9 3841.7 3930.8 1230.4 1261.5 1275.4 1278.8 1285.2 752.9 887.2 910.5 921.2 935.0 5627.6 5658.4 5668.8 5745.3 5938.0 845.2 854.3 891.5 947.1 964.5 3840.6 3951.7 3991.3 4022.8 4038.4 8802.7 8816.2 9017.7 9078.6 9125.0 9231.5 9288.9 9289.6 9314.2 9330.4 7275.6 7301.1 7375.0 7382.2 7397.6 5558.1 5574.1 5578.7 5595.9 5731.4 8989.5 9004.4 9081.4 9121.0 9133.3 8688.6 8953.9 8964.8 9033.2 9065.3 6511.9 7140.8 7255.7 7415.0 7447.5 7472.5 7486.7 7489.5 7503.4 7555.3 6465.3 6600.8 6657.1 6663.8 6743.6 6419.9 6476.6 6716.9 6801.0 6803.6 6529.3 6623.3 6624.1 6653.2 6658.1 4261.1 4784.2 4867.3 4889.8 4895.6 4887.1 4951.5 5023.7 5026.1 5030.5 07:24:00 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | [#4] prototype.html Cycles:180 Average:4714.38 Median:5388.14 stddev:1369.18 (25.4%) stddev-sans-first:1332.50 07:24:00 INFO - PROCESS | 3531 | Values: 309.2 318.1 319.9 321.6 330.7 5413.8 5467.9 5469.5 5482.5 5516.9 5370.4 5377.5 5378.8 5381.9 5394.4 3943.1 4041.2 4162.2 4163.5 4172.5 4183.6 4198.2 4206.5 4219.7 4224.0 4176.6 4179.8 4188.4 4188.4 4197.2 4105.2 4169.7 4175.8 4183.2 4190.9 3660.5 3661.4 3668.9 3672.9 3673.6 5173.1 5198.7 5214.8 5215.9 5221.1 4738.1 4825.5 4835.6 4861.1 4875.7 5674.5 5676.8 5705.5 5739.9 5750.7 4036.3 4044.6 4047.5 4055.6 4058.2 5779.9 5980.9 5997.3 6018.4 6054.8 4213.0 4213.6 4220.0 4225.4 4246.9 4296.1 4307.3 4308.3 4312.3 4313.5 4595.7 4841.2 4856.2 4860.8 4888.7 5750.6 5761.2 5764.9 5783.0 5799.7 1451.8 1465.2 1477.2 1482.3 1484.8 934.2 970.1 998.0 1006.3 1007.5 4845.8 4883.0 4893.8 4897.4 4906.4 5842.5 5868.3 5870.6 5876.7 5891.9 4769.3 4822.8 4861.1 4892.0 4921.5 3148.3 3163.1 3174.0 3175.3 3181.9 5432.4 5452.6 5463.3 5472.1 5474.6 5868.6 5991.4 6004.4 6019.9 6025.5 5418.2 5446.8 5469.2 5476.6 5478.2 5673.4 5822.0 5856.3 5864.2 5877.9 5660.4 5667.8 5675.1 5680.3 5687.8 5410.7 5420.2 5425.3 5461.4 5470.2 4106.7 4138.2 4176.7 4196.0 4267.6 5808.2 5809.9 5838.9 5867.3 5870.2 5631.7 5669.7 5673.6 5680.9 5690.8 5444.3 5583.4 5647.5 5658.3 5671.4 5435.3 5511.8 5581.7 5581.9 5587.7 5614.4 5806.4 5841.3 5848.0 5858.3 5638.8 5669.8 5687.3 5687.5 5699.1 07:24:00 INFO - PROCESS | 3531 | 07:24:00 INFO - PROCESS | 3531 | [#5] yui.html Cycles:180 Average:12389.37 Median:48160.52 stddev:13877.07 (28.8%) stddev-sans-first:13888.44 07:24:00 INFO - PROCESS | 3531 | Values: 743.5 757.2 760.4 770.8 775.4 12257.0 12673.3 12830.9 12842.7 12845.0 12082.3 12096.5 12745.4 12907.2 12929.5 644.9 781.4 812.9 824.2 828.3 817.2 817.3 818.8 819.3 820.2 854.1 854.7 857.3 858.0 859.3 848.2 854.1 856.0 856.6 857.6 624.1 626.2 626.6 629.2 631.5 11816.0 11873.4 11875.7 11891.8 11907.8 13029.4 13109.2 13150.0 13232.6 13288.8 9958.9 10211.4 10351.9 10358.8 10527.7 3336.5 3369.9 3406.5 3409.8 3423.6 47776.3 48387.5 48823.5 48910.5 49100.3 9229.0 9388.6 9909.3 10188.3 10193.6 17142.4 17195.4 17203.7 17225.4 17250.7 7114.8 7149.7 7162.9 7181.2 7415.8 3848.4 3891.2 3896.1 3973.7 3998.4 2839.2 2867.8 2873.3 3117.8 3267.6 590.9 596.7 600.8 601.3 602.1 615.9 619.2 627.5 654.4 659.6 8055.3 8395.2 8428.7 8795.6 8829.4 595.7 602.9 604.9 627.8 629.3 3623.8 3706.9 3900.1 3920.6 3981.5 42623.4 44823.1 45080.5 45191.8 45317.5 40484.8 46082.5 46818.1 47716.0 47933.5 41615.0 41872.0 41877.8 41985.4 42061.4 7420.6 7723.8 7781.1 7820.3 7974.4 27403.3 28021.3 28354.9 28656.1 28973.6 34303.5 37492.6 37562.8 37732.0 37779.0 9770.9 9810.4 9865.2 9884.8 9996.4 10295.0 10405.9 10504.3 10840.6 10984.8 9872.9 9973.7 10062.9 10152.3 10249.6 9700.9 9967.4 10025.8 10033.7 10508.2 9931.9 9965.7 10003.2 10270.8 10330.7 8693.7 8779.5 8981.0 9022.4 9527.6 8401.7 8467.8 8510.4 8581.2 8618.7 07:24:00 INFO - PROCESS | 3531 | -------- Summary: end -------- 07:24:00 INFO - PROCESS | 3531 | 07:24:01 INFO - TEST-INFO | 3531: exit 0 07:24:01 INFO - TEST-OK | dromaeo_css | took 1116119ms 07:24:01 INFO - TEST-START | kraken 07:24:01 INFO - operating with platform_type : linux_ 07:24:01 INFO - Initialising browser for kraken test... 07:24:01 INFO - TEST-INFO | started process 3765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpedyK4C/profile http://localhost:36870/getInfo.html) 07:24:04 INFO - PROCESS | 3765 | 07:24:04 INFO - PROCESS | 3765 | (process:3834): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:24:05 INFO - PROCESS | 3765 | __metrics Screen width/height:1600/1200 07:24:05 INFO - PROCESS | 3765 | colorDepth:24 07:24:05 INFO - PROCESS | 3765 | Browser inner width/height: 1024/697 07:24:05 INFO - PROCESS | 3765 | __metrics 07:24:06 ERROR - PROCESS | 3765 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:24:06 INFO - TEST-INFO | 3765: exit 0 07:24:06 INFO - Browser initialized. 07:24:06 INFO - Running cycle 1/1 for kraken test... 07:24:06 INFO - TEST-INFO | started process 3885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpedyK4C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:08 INFO - PROCESS | 3885 | 07:24:08 INFO - PROCESS | 3885 | (process:3945): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:24:18 INFO - PROCESS | 3885 | RSS: Main: 166232064 07:24:18 INFO - PROCESS | 3885 | 07:24:21 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36870/tests/kraken/driver.html?testName=audio-beat-detection) 07:24:22 INFO - PROCESS | 3885 | RSS: Main: 168955904 07:24:22 INFO - PROCESS | 3885 | 07:24:25 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36870/tests/kraken/driver.html?testName=audio-dft) 07:24:26 INFO - PROCESS | 3885 | RSS: Main: 173232128 07:24:26 INFO - PROCESS | 3885 | 07:24:28 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36870/tests/kraken/driver.html?testName=audio-fft) 07:24:29 INFO - PROCESS | 3885 | RSS: Main: 165203968 07:24:29 INFO - PROCESS | 3885 | 07:24:31 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36870/tests/kraken/driver.html?testName=audio-oscillator) 07:24:32 INFO - PROCESS | 3885 | RSS: Main: 165924864 07:24:32 INFO - PROCESS | 3885 | 07:24:34 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:24:35 INFO - PROCESS | 3885 | RSS: Main: 165171200 07:24:35 INFO - PROCESS | 3885 | 07:24:38 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36870/tests/kraken/driver.html?testName=imaging-darkroom) 07:24:39 INFO - PROCESS | 3885 | RSS: Main: 165883904 07:24:39 INFO - PROCESS | 3885 | 07:24:42 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36870/tests/kraken/driver.html?testName=imaging-desaturate) 07:24:43 INFO - PROCESS | 3885 | RSS: Main: 163971072 07:24:43 INFO - PROCESS | 3885 | 07:24:46 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36870/tests/kraken/driver.html?testName=json-parse-financial) 07:24:46 INFO - PROCESS | 3885 | RSS: Main: 165015552 07:24:46 INFO - PROCESS | 3885 | 07:24:48 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:24:49 INFO - PROCESS | 3885 | RSS: Main: 165076992 07:24:49 INFO - PROCESS | 3885 | 07:24:51 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36870/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:24:51 INFO - PROCESS | 3885 | RSS: Main: 164892672 07:24:51 INFO - PROCESS | 3885 | 07:24:53 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:24:54 INFO - PROCESS | 3885 | RSS: Main: 165216256 07:24:54 INFO - PROCESS | 3885 | 07:24:57 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:24:58 INFO - PROCESS | 3885 | RSS: Main: 166154240 07:24:58 INFO - PROCESS | 3885 | 07:25:01 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:25:01 INFO - PROCESS | 3885 | RSS: Main: 166367232 07:25:01 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | Cycle 1(1): loaded http://localhost:36870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36870/tests/kraken/driver.html?testName=ai-astar) 07:25:03 INFO - PROCESS | 3885 | RSS: Main: 167333888 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | __start_tp_report 07:25:03 INFO - PROCESS | 3885 | _x_x_mozilla_page_load 07:25:03 INFO - PROCESS | 3885 | _x_x_mozilla_page_load_details 07:25:03 INFO - PROCESS | 3885 | |i|pagename|runs| 07:25:03 INFO - PROCESS | 3885 | |0;ai-astar;117;111;114;114;114;130;114;114;113;113 07:25:03 INFO - PROCESS | 3885 | |1;audio-beat-detection;157;135;156;192;138;168;171;134;188;131 07:25:03 INFO - PROCESS | 3885 | |2;audio-dft;162;161;165;175;162;161;161;162;163;162 07:25:03 INFO - PROCESS | 3885 | |3;audio-fft;78;73;74;163;78;78;73;73;152;74 07:25:03 INFO - PROCESS | 3885 | |4;audio-oscillator;94;94;138;99;94;94;142;94;94;152 07:25:03 INFO - PROCESS | 3885 | |5;imaging-gaussian-blur;118;118;118;118;119;118;118;118;117;117 07:25:03 INFO - PROCESS | 3885 | |6;imaging-darkroom;146;146;147;147;147;147;147;148;147;150 07:25:03 INFO - PROCESS | 3885 | |7;imaging-desaturate;95;95;95;95;96;95;96;96;95;95 07:25:03 INFO - PROCESS | 3885 | |8;json-parse-financial;67;68;66;68;67;66;67;67;67;67 07:25:03 INFO - PROCESS | 3885 | |9;json-stringify-tinderbox;63;64;68;65;65;65;64;64;65;66 07:25:03 INFO - PROCESS | 3885 | |10;stanford-crypto-aes;87;88;81;80;79;80;81;81;106;82 07:25:03 INFO - PROCESS | 3885 | |11;stanford-crypto-ccm;133;142;132;139;135;148;137;137;135;134 07:25:03 INFO - PROCESS | 3885 | |12;stanford-crypto-pbkdf2;173;171;177;173;172;172;174;173;174;173 07:25:03 INFO - PROCESS | 3885 | |13;stanford-crypto-sha256-iterative;73;73;74;76;74;71;75;73;74;73 07:25:03 INFO - PROCESS | 3885 | __end_tp_report 07:25:03 INFO - PROCESS | 3885 | __start_cc_report 07:25:03 INFO - PROCESS | 3885 | _x_x_mozilla_cycle_collect,908 07:25:03 INFO - PROCESS | 3885 | __end_cc_report 07:25:03 INFO - PROCESS | 3885 | __startTimestamp1461507903708__endTimestamp 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | ------- Summary: start ------- 07:25:03 INFO - PROCESS | 3885 | Number of tests: 14 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#0] ai-astar Cycles:10 Average:115.40 Median:114.00 stddev:5.34 (4.7%) stddev-sans-first:5.63 07:25:03 INFO - PROCESS | 3885 | Values: 117.0 111.0 114.0 114.0 114.0 130.0 114.0 114.0 113.0 113.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:162.50 stddev:22.49 (13.8%) stddev-sans-first:23.86 07:25:03 INFO - PROCESS | 3885 | Values: 157.0 135.0 156.0 192.0 138.0 168.0 171.0 134.0 188.0 131.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.00 stddev:4.25 (2.6%) stddev-sans-first:4.48 07:25:03 INFO - PROCESS | 3885 | Values: 162.0 161.0 165.0 175.0 162.0 161.0 161.0 162.0 163.0 162.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#3] audio-fft Cycles:10 Average:91.60 Median:74.00 stddev:34.89 (47.2%) stddev-sans-first:36.66 07:25:03 INFO - PROCESS | 3885 | Values: 78.0 73.0 74.0 163.0 78.0 78.0 73.0 73.0 152.0 74.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:94.00 stddev:24.10 (25.6%) stddev-sans-first:24.90 07:25:03 INFO - PROCESS | 3885 | Values: 94.0 94.0 138.0 99.0 94.0 94.0 142.0 94.0 94.0 152.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:25:03 INFO - PROCESS | 3885 | Values: 118.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 117.0 117.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 07:25:03 INFO - PROCESS | 3885 | Values: 146.0 146.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 150.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:25:03 INFO - PROCESS | 3885 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 07:25:03 INFO - PROCESS | 3885 | Values: 67.0 68.0 66.0 68.0 67.0 66.0 67.0 67.0 67.0 67.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:1.27 07:25:03 INFO - PROCESS | 3885 | Values: 63.0 64.0 68.0 65.0 65.0 65.0 64.0 64.0 65.0 66.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:81.00 stddev:8.13 (10.0%) stddev-sans-first:8.57 07:25:03 INFO - PROCESS | 3885 | Values: 87.0 88.0 81.0 80.0 79.0 80.0 81.0 81.0 106.0 82.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:137.00 stddev:4.80 (3.5%) stddev-sans-first:4.85 07:25:03 INFO - PROCESS | 3885 | Values: 133.0 142.0 132.0 139.0 135.0 148.0 137.0 137.0 135.0 134.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.00 stddev:1.62 (0.9%) stddev-sans-first:1.72 07:25:03 INFO - PROCESS | 3885 | Values: 173.0 171.0 177.0 173.0 172.0 172.0 174.0 173.0 174.0 173.0 07:25:03 INFO - PROCESS | 3885 | 07:25:03 INFO - PROCESS | 3885 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:1.35 (1.8%) stddev-sans-first:1.41 07:25:03 INFO - PROCESS | 3885 | Values: 73.0 73.0 74.0 76.0 74.0 71.0 75.0 73.0 74.0 73.0 07:25:03 INFO - PROCESS | 3885 | -------- Summary: end -------- 07:25:03 INFO - PROCESS | 3885 | 07:25:04 INFO - TEST-INFO | 3885: exit 0 07:25:04 INFO - TEST-OK | kraken | took 63479ms 07:25:04 INFO - SUITE-END | took 1179s 07:25:04 INFO - Completed test suite (00:19:39) 07:25:04 INFO - javascript benchmark 07:25:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.356787587041, 2643.8810253538595, 2712.0914493644627, 2743.87652555635, 2744.8627568621578, 4735.928961065587, 4784.425868895729, 4803.039392121572, 4817.951820481794, 4850.3694519712435, 4661.790219440125, 4745.667803253774, 4808.99011207646, 4842.830500932468, 4876.390451193601, 4368.104538569602, 4425.800838962238, 4507.053518761048, 4522.5025247222775, 4543.182227199103, 488.9334997400232, 4319.330503771905, 4337.154254920292, 4343.804528796211, 4392.275274579706, 4346.022145017361, 4351.782410879443, 4362.302031674949, 4363.738175709467, 4416.492103408117, 4345.9130817383475, 4353.673474489426, 4356.194104090721, 4393.494748103945, 4416.712913660634, 4338.327559228324, 4400.7579583122915, 4408.647308215335, 4428.623566996777, 4458.754768487732, 4698.318743782167, 4704.858854234379, 4752.857414277577, 4758.595519380857, 4763.261694437368, 5025.14572522672, 5090.770915308783, 5179.663321884065, 5185.896282074337, 5226.843194704127, 5186.559142472895, 5224.4775522447835, 5238.5809135269465, 5241.135212689902, 5282.894342113136, 4832.106060378841, 4861.440934292566, 4861.586765125004, 4883.536064073907, 4895.192293271606, 5214.530692237717, 5254.92117618236, 5294.655847369909, 5320.388155362106, 5358.11591087474, 5032.823851165192, 5037.143685573461, 5037.5214354636255, 5073.898522029539, 5124.154514505065, 5152.510511501401, 5159.896802063938, 5170.40540337866, 5182.870428239249, 5191.454897235812, 4973.900521989613, 5119.360079990001, 5135.3324067870935, 5188.792448302102, 5220.634555581149, 5106.15748401517, 5114.43741188469, 5118.820841270538, 5124.7950081996305, 5129.333186685782, 4424.867253982386, 4427.158839820424, 4429.224885645, 4435.223835828717, 4477.261251893467, 3732.1789206375097, 3762.266358060152, 3785.280796648628, 3882.1653344530496, 3948.7433316834313, 4402.647788176938, 4415.183191109655, 4462.286034234572, 4485.708428952108, 4496.033352829158, 5180.352455943007, 5194.454582268883, 5195.090859099642, 5206.375234971828, 5207.7916883325, 4275.4441922550495, 4444.711093778894, 4481.327800829901, 4512.097580483916, 4517.841875534341, 4560.68075234737, 4622.34314567579, 4625.930611040837, 4631.722096674143, 4669.2062349400685, 4806.062817750505, 4812.181929072136, 4827.106985207748, 4827.710337379768, 4863.3434486344595, 5098.796048158032, 5165.044466773659, 5226.581873450191, 5258.421573626822, 5263.499967503081, 4808.855734327975, 4810.254410566367, 4830.541098595628, 4830.830920917751, 4878.048780487771, 4967.552920237196, 5032.119379108568, 5033.5721463676, 5058.443571207091, 5067.695938243717, 5152.27868098459, 5213.218017297436, 5220.791168353375, 5254.290670759551, 5286.735663216747, 4937.629677774109, 4943.456219815889, 4944.629152813482, 4954.3311652926395, 5020.974895125501, 4856.320115183807, 4878.63410244226, 4949.950500495093, 4954.380702412199, 4961.950380496149, 4969.975150124226, 4980.9501904981935, 4988.4263309719845, 5001.224810154432, 5043.394792624908, 5083.694978301313, 5084.211947148198, 5119.180931051014, 5127.102757017582, 5162.0, 4776.665633405628, 4856.39295088114, 4962.751862406937, 5008.298838162587, 5023.045621331935], "value": 4697.579556777007, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3588844605595, 605.7576969212314, 612.7579606055606, 623.4762799248632, 641.9935800641993, 34789.0, 36113.81943090281, 36132.1094312455, 36179.27641447169, 36208.27583448329, 39069.65582065078, 39660.40509392361, 39662.0, 39798.80100599493, 39940.80029599848, 7718.2281771822645, 7846.882296765553, 7859.174786647377, 7896.842063158733, 7908.406869484783, 7734.226577342249, 7819.452638315321, 7824.921750782476, 7844.68621255152, 7846.764597062097, 7832.843343133134, 7855.371570274365, 7869.173736757644, 7908.367330613537, 7928.524288542706, 7765.53406795594, 7831.2560306770765, 7865.17415671352, 7868.291853733192, 7871.724489642864, 7793.688252469894, 7864.606769661551, 7896.0, 7903.762887113396, 7931.167227441151, 29710.40579188404, 36884.81557592221, 37323.06692332686, 37396.0, 37420.625793742256, 3030.636323641177, 3094.6930384304005, 3110.0669799060192, 3670.247599242149, 3914.64768170866, 25093.121740738985, 25127.497450050898, 25856.353591160183, 25915.22254332373, 26126.085587004553, 3138.7802853800245, 3144.5912031435996, 3173.76196785242, 3187.729043031345, 3199.6480387157394, 185240.0, 186179.0, 186961.0, 187453.0, 188393.0, 32356.35287294241, 32553.51169732456, 32581.18547036343, 32584.348313033606, 33751.32497350039, 32241.838790805898, 32434.0, 32484.837575812442, 32675.0, 32675.509867352008, 11784.0, 12045.15683902136, 12098.637040888787, 12113.939430302793, 12137.089718271165, 10497.422641754623, 10714.0, 10728.839067413996, 10737.0, 10741.301815381976, 8095.757127286191, 8108.351331893435, 8168.305694016075, 8275.255227029596, 8293.419460637697, 3217.2761128746315, 3234.1429521176906, 3246.6753324667343, 3280.801862751962, 3297.7196938260035, 927.0, 1031.3038698878227, 1032.4166845732138, 1048.171944164102, 1086.4241951765578, 28369.574456383172, 28433.28916777097, 28484.287892802433, 28530.857345713554, 28791.856040720082, 1014.1886490807325, 1048.4810019040472, 1057.49768859791, 1101.493313075978, 1142.4230763464398, 14729.779053314209, 14936.551903442914, 14968.75468679685, 15254.389824406899, 15451.690966180613, 369889.0, 375725.0, 377913.0, 378401.0, 380017.0, 47311.0, 48172.27741583879, 48358.0, 48460.757696212, 48538.75730621395, 1231.1012960538858, 1232.3345393487596, 1236.3014896583582, 1257.3147634539198, 1277.0932637827061, 26378.34054148585, 27391.589126163522, 27531.0, 27699.89200432041, 27931.441371172055, 43162.56837431585, 43425.56574434342, 43734.0, 43856.56143438525, 43908.78045609751, 330844.0, 331926.0, 332279.0, 333628.0, 334366.0, 24010.759892400853, 24241.151559695325, 24251.63622545628, 24291.271261862174, 24302.270931872074, 43633.781831090644, 43804.0, 44570.0, 44594.108117838114, 44683.32975005443, 31788.523172151974, 32474.512882307255, 33006.0, 33136.834315829234, 33474.33051338911, 34023.82988085044, 34038.48942265918, 34289.828550857084, 34297.65702342945, 34634.13414664553, 34947.825260873535, 35139.29721405506, 37002.44496332503, 37879.43180852234, 37907.0, 29929.551056734603, 30701.385972279983, 31336.304230530746, 31825.68174318227, 31895.68104318927, 24372.146974856503, 24377.14679986192, 24379.756202437748, 24690.876545617877, 24943.87528062348], "value": 16046.235057108657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.9818009099544, 366.748777087695, 379.538860284754, 386.3798603241798, 395.46414608205885, 15914.204289785508, 16182.514524564267, 16391.344346226168, 16459.506214813544, 17036.659266814688, 16327.83672163278, 16552.420665276717, 17209.13954302283, 17296.30814767411, 17362.56593585161, 5087.872803179922, 5240.764165612538, 5241.187615919539, 5271.5782737381105, 5275.868103297429, 3762.868299609514, 5145.897082058356, 5889.0, 6214.254289485268, 6220.6267623942485, 6120.969395153018, 6150.169727086831, 6153.0155175171985, 6173.81478555644, 6177.969110154443, 6660.100886380349, 7022.508424410294, 7026.191987921404, 7102.14774227096, 7104.431645468376, 6599.736010559572, 6837.555558888656, 6895.275996020446, 6919.100516932817, 6935.133108361455, 22409.43976400603, 22452.88773556138, 23573.88213058941, 24244.515109697706, 24496.387590310384, 1924.7401600783855, 2058.372196480073, 2094.5810837832496, 2118.6080575093656, 2122.373899699592, 13710.657233569142, 13870.0, 14121.576352709435, 14494.202818844959, 15193.392264309414, 1625.2929975460595, 1875.5873707784265, 1920.1374666573402, 1921.567647279365, 1973.9111739971593, 79631.20368796354, 80893.0, 81539.59230203812, 81687.5915620424, 83194.0, 16631.91684041596, 16783.412580559623, 17059.0, 17075.743863842054, 17335.133243337783, 29704.40591188164, 29859.0, 29881.252968675955, 29929.251768705955, 29949.401011979637, 7952.32405245549, 8148.388870834711, 8260.917390826135, 8276.172382761795, 8294.668213271521, 6548.508861835381, 6566.6388348641285, 6654.23476300222, 6678.565893216925, 6768.72925083001, 8380.748577542683, 8443.324534037261, 8494.787630309293, 8520.659173633108, 8524.786880327918, 1847.8152184781684, 1924.970140974572, 1944.8152425519554, 1991.73111629931, 3446.5174875516946, 872.6334939325499, 927.2535608834818, 935.2331088507494, 940.9294302927308, 941.7692665296909, 16007.919960400124, 16131.838681613033, 16353.918230408772, 16509.83490165083, 16831.831681683027, 874.7069731639845, 876.7632739160391, 879.5426378283257, 922.1516205091332, 972.7811242470387, 9387.812243755086, 9474.905250947402, 9506.33455658111, 9516.809663806685, 9525.952370238105, 388073.0, 395605.0, 395961.0, 398064.0, 404105.0, 75630.62184689041, 80607.59696201599, 82161.17838821655, 82169.17830821735, 83262.0, 951.1059603972244, 962.7448726087592, 970.6602689058773, 977.1010670183448, 978.8433850584015, 14696.853031469976, 14798.852011479747, 15062.322195501449, 15115.395384184509, 15427.074375537504, 33299.83350083234, 33606.32787344288, 34334.0, 35006.64993350136, 35239.0, 46781.0, 46807.53192468168, 49216.50783492119, 49312.0, 49929.251061234834, 7532.8493430132185, 7722.111957125003, 7725.845483090419, 7750.496217745828, 7757.573333466714, 7824.139344671968, 9226.630934762534, 10675.89324106749, 10840.891591083988, 10918.23572349928, 9829.213662906806, 9874.605015799574, 10005.649802256887, 10044.488877780555, 10110.69667909964, 9361.765955851159, 9374.156325930426, 9443.905560944577, 9514.33399662017, 9981.750456238653, 9783.217342612432, 10182.694519164437, 10250.128739057263, 10254.077133058061, 10255.794884102126, 7559.395248380007, 7588.81027974305, 7592.772216833504, 7622.161562228262, 7665.770026899202, 8924.68763593271, 9465.148136667733, 9533.332666713264, 9586.328956973224, 9801.754956126153], "value": 9032.142202176587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.7599646058397, 1487.0259979713287, 1627.5768300241934, 1744.6772347115777, 1809.692352300109, 6968.860622787542, 7591.0890693116835, 7602.087749470057, 7880.921190788091, 7903.407244456667, 7609.353204977583, 7616.124145723244, 7651.1583725790115, 7693.846123077535, 7706.6146692665425, 2208.05053826854, 2211.6019116559014, 2230.7434645015787, 2238.608243557379, 2243.170027089979, 2188.245055455873, 2226.0539270809923, 2228.487447886987, 2233.1737257214854, 2234.452559123017, 2196.890155492219, 2217.1020736601704, 2217.3347995601334, 2222.355516900105, 2244.0, 2126.8192203662707, 2160.1899287767087, 2165.85921915075, 2175.7062796522423, 2177.0203408466255, 2232.888355582231, 2236.4408897775556, 2253.966190507144, 2257.6274914639066, 2261.502469456717, 7765.223477652246, 7813.140554538996, 7857.882131768028, 7866.921330786676, 7887.487313324616, 4546.545345465427, 4679.181143299943, 4692.859214223578, 4703.670743047988, 4716.174669432836, 2987.357718090599, 3049.9085027449214, 3058.831764252965, 3059.5563643271603, 3080.86136123875, 912.0833562269943, 932.8181004704086, 954.6706386296717, 955.1737746848995, 972.4651441707103, 10730.0, 10791.190660700478, 10805.621803236927, 10839.241253112206, 10905.34567925927, 4314.848980285675, 4323.459567554056, 4505.909881802346, 4513.54864513546, 4550.294704320836, 9181.58682859273, 9194.678186263582, 9219.0, 9231.35380523357, 9236.399634023766, 4788.449328327218, 4821.349117869043, 4845.830395936126, 4865.172920603506, 4868.0, 3813.866514671973, 4077.89805254871, 4179.6029377209115, 4374.518802931675, 4381.277089280296, 3730.4963829882618, 3756.1924186300075, 3819.8854034379015, 3841.654251117413, 3930.803459827054, 1230.39095647655, 1261.5080118753694, 1275.3623188405797, 1278.8273583066166, 1285.2417073926242, 752.9397648188132, 887.2414085956543, 910.5128756115447, 921.2169655792522, 934.9953250233841, 5627.634203776742, 5658.434156584391, 5668.801591944262, 5745.2818397700285, 5938.049912014057, 845.2055068235961, 854.3421565394611, 891.5007595746403, 947.0907928388687, 964.4647220792527, 3840.5967373425947, 3951.664108550748, 3991.261616600938, 4022.8390864365683, 4038.353863381845, 8802.691905783267, 8816.206541411175, 9017.684381046633, 9078.591463384164, 9125.041870603623, 9231.492267925194, 9288.907110928803, 9289.581968811419, 9314.161725444743, 9330.440173589606, 7275.599842008634, 7301.123865136217, 7375.04124463827, 7382.18795932447, 7397.593132377663, 5558.082916318762, 5574.136008918624, 5578.721063946868, 5595.944040559542, 5731.426857314235, 8989.46063236208, 9004.41471304363, 9081.409708368936, 9121.0, 9133.315001375056, 8688.609012594323, 8953.92552893657, 8964.775880603038, 9033.187013168847, 9065.32010099232, 6511.892978193624, 7140.821479463055, 7255.709771609077, 7414.962925185555, 7447.478676492594, 7472.514286571355, 7486.700531978878, 7489.513181643176, 7503.362214211853, 7555.320021198118, 6465.288818229897, 6600.808486611132, 6657.101291325609, 6663.800085997428, 6743.561668491532, 6419.871602567829, 6476.579022363531, 6716.899246511209, 6800.965995169992, 6803.557768745214, 6529.347065293433, 6623.271440141484, 6624.105745724266, 6653.168353955755, 6658.067870498037, 4261.126469073894, 4784.162771515041, 4867.29424233477, 4889.755512224446, 4895.608351331956, 4887.120318342732, 4951.5048495150195, 5023.7488125592845, 5026.095302845523, 5030.4718004608985], "value": 4251.820723445088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.236186619051, 318.05061890257576, 319.9248176678479, 321.5787318612617, 330.70071585215373, 5413.756380962856, 5467.9453205467935, 5469.495888630624, 5482.451754824516, 5516.862078448041, 5370.43610420906, 5377.542908852753, 5378.838634840961, 5381.919271210925, 5394.352677678674, 3943.132510847609, 4041.1513582147636, 4162.209180255742, 4163.479565054368, 4172.457580514544, 4183.602557757008, 4198.181354635847, 4206.516250631171, 4219.683523735716, 4223.957760422402, 4176.582341765814, 4179.770112643803, 4188.392683060954, 4188.413622092894, 4197.244495990721, 4105.240530501852, 4169.708120431571, 4175.828569144028, 4183.163367326531, 4190.874273771792, 3660.4509323601405, 3661.3775658137915, 3668.853245870162, 3672.926541469182, 3673.6326367363317, 5173.094708426048, 5198.714070726109, 5214.765335559909, 5215.947840521622, 5221.112410890158, 4738.123447162252, 4825.517448255181, 4835.564799168056, 4861.124997500448, 4875.658703890729, 5674.546036317085, 5676.829695109112, 5705.457981491793, 5739.885202295931, 5750.712464376765, 4036.253293140749, 4044.5753195914594, 4047.5024241030715, 4055.5741647127215, 4058.1883623275166, 5779.884402311972, 5980.880382392371, 5997.311653333212, 6018.398160183947, 6054.757809687607, 4212.957870421256, 4213.599708027732, 4220.0, 4225.366195070703, 4246.936295955563, 4296.10013241061, 4307.289297265916, 4308.332208507686, 4312.331588603772, 4313.525512193656, 4595.655325850575, 4841.201201801734, 4856.174450343379, 4860.80556777732, 4888.653446345774, 5750.568707346965, 5761.222234998306, 5764.942350576524, 5783.0, 5799.652020878761, 1451.7894905238682, 1465.230753854235, 1477.2023107522032, 1482.3107255126417, 1484.834404992076, 934.2432629569934, 970.0784254957819, 997.9800403991879, 1006.3257617396362, 1007.4912169354429, 4845.75771211445, 4883.0, 4893.828715994923, 4897.363342765489, 4906.362172917497, 5842.474177323977, 5868.325142608569, 5870.559708021916, 5876.706164691748, 5891.882162356729, 4769.332293478916, 4822.791819943806, 4861.149298872683, 4892.0, 4921.50784921505, 3148.291634382246, 3163.114327988167, 3174.0477856642915, 3175.3490534440384, 3181.8886338978486, 5432.402435732066, 5452.563794896478, 5463.289772329651, 5472.069748142825, 5474.562035037187, 5868.559858010581, 5991.400859914061, 6004.427365717478, 6019.939800602026, 6025.457708806229, 5418.160185171305, 5446.836594902159, 5469.234307196995, 5476.561875050066, 5478.178273259043, 5673.404292549223, 5822.0, 5856.297244330707, 5864.208331875142, 5877.94122058774, 5660.37735849048, 5667.829965101054, 5675.148727690879, 5680.318361796611, 5687.829365119053, 5410.702411367412, 5420.2140689599, 5425.267588875451, 5461.361591522448, 5470.179473078911, 4106.733062350938, 4138.172365526846, 4176.7076304658385, 4196.0, 4267.615914567704, 5808.21589085485, 5809.883802324014, 5838.912416313844, 5867.295924489089, 5870.178175055581, 5631.690257035739, 5669.688167150846, 5673.602847800615, 5680.857978550569, 5690.800821971211, 5444.3194600674915, 5583.3708089741995, 5647.519960803378, 5658.349289831722, 5671.376148623731, 5435.320584926884, 5511.834644960658, 5581.693006884498, 5581.916271255853, 5587.664740115606, 5614.410486898817, 5806.419358064329, 5841.269841269841, 5847.970760146172, 5858.326292476419, 5638.774449021993, 5669.81712040859, 5687.3459552152035, 5687.5449964001955, 5699.088145896637], "value": 4276.701499777075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.475849526084, 757.2427572427572, 760.410681721666, 770.7918861907285, 775.3951917504348, 12257.0, 12673.302968336739, 12830.871691283097, 12842.678933026678, 12845.0, 12082.275063496174, 12096.455659495321, 12745.362731863415, 12907.225566465995, 12929.482820687184, 644.8549076457806, 781.4295564238109, 812.9105798362175, 824.2087595907935, 828.2918105020211, 817.1746535998625, 817.3175398542224, 818.7993941484344, 819.3445243804962, 820.24127681894, 854.0647990450447, 854.692310768126, 857.2670366836359, 857.9656813727444, 859.3039637893295, 848.240824462106, 854.0647990450447, 855.9614817333235, 856.618804631939, 857.5755001274377, 624.073251221935, 626.1859582542722, 626.589583822597, 629.2197674883158, 631.4601016131188, 11816.0, 11873.406329683568, 11875.703107422383, 11891.821622675667, 11907.821382679267, 13029.413676384585, 13109.213447193199, 13150.0, 13232.603021909357, 13288.800667989988, 9958.850617240747, 10211.438370889598, 10351.896481035168, 10358.792824143475, 10527.684169474927, 3336.466165413522, 3369.949450758241, 3406.5401170842115, 3409.8295085245886, 3423.640517745626, 47776.28335574934, 48387.51612483901, 48823.51176488225, 48910.510894890955, 49100.263496047584, 9229.0, 9388.62445502186, 9909.256805739598, 10188.319879539074, 10193.592256309665, 17142.40001599938, 17195.398161064302, 17203.741943870602, 17225.39711110105, 17250.65498690019, 7114.786556403316, 7149.714011439588, 7162.856742865113, 7181.174164970991, 7415.8146046349275, 3848.3650197717625, 3891.1828516011956, 3896.103896103912, 3973.7019723520852, 3998.420229066769, 2839.1766387747734, 2867.842268675201, 2873.281679580105, 3117.828519431453, 3267.5752152220534, 590.8759160576327, 596.7463827873137, 600.7987324246426, 601.3385276196236, 602.1148911100674, 615.8614311779813, 619.2166908860295, 627.5168120547245, 654.3946849164504, 659.643792352134, 8055.275025247756, 8395.202455766692, 8428.704995325257, 8795.604197810986, 8829.38194326391, 595.7021489255372, 602.9457348838538, 604.9395060493915, 627.7928283666379, 629.2920464477463, 3623.7825730456257, 3706.8887933362043, 3900.1224724436775, 3920.6079392061138, 3981.5421226559315, 42623.36064959028, 44823.103537929055, 45080.54919450829, 45191.774041130244, 45317.54682453133, 40484.79757601193, 46082.53917460849, 46818.06363872772, 47716.0, 47933.52066479361, 41615.0, 41872.0, 41877.79061104675, 41985.370219447344, 42061.36907946383, 7420.628968551443, 7723.845523089619, 7781.144074151725, 7820.257075577811, 7974.441789074941, 27403.31491712723, 28021.299467513476, 28354.85822570874, 28656.14031579056, 28973.565396518647, 34303.4854477178, 37492.62507374891, 37562.81218593889, 37732.0, 37779.0, 9770.853437198306, 9810.411375317504, 9865.210783137189, 9884.752881178028, 9996.400215987063, 10295.0, 10405.895941040493, 10504.317219380715, 10840.620578280037, 10984.780304394028, 9872.851907221253, 9973.650922217688, 10062.899371006197, 10152.289339746147, 10249.590016399261, 9700.854487182556, 9967.40195588238, 10025.849612255968, 10033.74915627086, 10508.211884108876, 9931.851022234529, 9965.701028969142, 10003.249756268455, 10270.794584108426, 10330.690079297332, 8693.652253909773, 8779.517126558101, 8980.955095224743, 9022.368434209542, 9527.57125929321, 8401.747947561584, 8467.78830529217, 8510.361722870686, 8581.184787445183, 8618.698345557876], "value": 5904.785849159701, "unit": "score"}], "name": "dromaeo_css", "value": 6466.381530609915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 114.0, 114.0, 114.0, 130.0, 114.0, 114.0, 113.0, 113.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 135.0, 156.0, 192.0, 138.0, 168.0, 171.0, 134.0, 188.0, 131.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 165.0, 175.0, 162.0, 161.0, 161.0, 162.0, 163.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 74.0, 163.0, 78.0, 78.0, 73.0, 73.0, 152.0, 74.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 138.0, 99.0, 94.0, 94.0, 142.0, 94.0, 94.0, 152.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 150.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 68.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 81.0, 80.0, 79.0, 80.0, 81.0, 81.0, 106.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 142.0, 132.0, 139.0, 135.0, 148.0, 137.0, 137.0, 135.0, 134.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 177.0, 173.0, 172.0, 172.0, 174.0, 173.0, 174.0, 173.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 76.0, 74.0, 71.0, 75.0, 73.0, 74.0, 73.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1597.7, "alertThreshold": 2.0}]} 07:25:04 INFO - Return code: 0 07:25:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:25:04 ERROR - # TBPL SUCCESS # 07:25:04 INFO - Running post-action listener: _resource_record_post_action 07:25:05 INFO - Running post-run listener: _resource_record_post_run 07:25:06 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7790592; Write bytes: 367841280; Read time: 1508; Write time: 290356 07:25:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 10899456; Read time: 0; Write time: 19036 07:25:06 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 7786496; Write bytes: 309395456; Read time: 1400; Write time: 244096 07:25:06 INFO - Running post-run listener: _upload_blobber_files 07:25:06 INFO - Blob upload gear active. 07:25:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:25:06 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 07:25:06 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'] 07:25:06 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 07:25:06 INFO - (blobuploader) - INFO - Open directory for files ... 07:25:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:25:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:25:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:07 INFO - (blobuploader) - INFO - Done attempting. 07:25:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:25:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:25:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:08 INFO - (blobuploader) - INFO - Done attempting. 07:25:08 INFO - (blobuploader) - INFO - Iteration through files over. 07:25:08 INFO - Return code: 0 07:25:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:25:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:25:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3849e616da75e4934704eccae9a4ee0115e892e174f3fea52309473222bf522985851d6d2e720d07a20abff3369c49da87cb76a0cbeb06b2faa7c571216cd0ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e39066909af58adc3d14b738ed88e5a73177d3a510a81ef614184a0fc54b8de845a7c8ebbad4e2618428009b208e4b715991f4de9d928fe1838a16e7f29fc50"} 07:25:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:25:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:25:08 INFO - Contents: 07:25:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3849e616da75e4934704eccae9a4ee0115e892e174f3fea52309473222bf522985851d6d2e720d07a20abff3369c49da87cb76a0cbeb06b2faa7c571216cd0ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e39066909af58adc3d14b738ed88e5a73177d3a510a81ef614184a0fc54b8de845a7c8ebbad4e2618428009b208e4b715991f4de9d928fe1838a16e7f29fc50"} 07:25:08 INFO - Running post-run listener: copy_logs_to_upload_dir 07:25:08 INFO - Copying logs to upload dir... 07:25:08 INFO - mkdir: /builds/slave/test/build/upload/logs 07:25:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.991752 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-24 07:25:07.881523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 07:25:07.885132) ========= 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=ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3849e616da75e4934704eccae9a4ee0115e892e174f3fea52309473222bf522985851d6d2e720d07a20abff3369c49da87cb76a0cbeb06b2faa7c571216cd0ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e39066909af58adc3d14b738ed88e5a73177d3a510a81ef614184a0fc54b8de845a7c8ebbad4e2618428009b208e4b715991f4de9d928fe1838a16e7f29fc50"} build_url:https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/UJGS40RuSNSGskMbcoQ7_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3849e616da75e4934704eccae9a4ee0115e892e174f3fea52309473222bf522985851d6d2e720d07a20abff3369c49da87cb76a0cbeb06b2faa7c571216cd0ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e39066909af58adc3d14b738ed88e5a73177d3a510a81ef614184a0fc54b8de845a7c8ebbad4e2618428009b208e4b715991f4de9d928fe1838a16e7f29fc50"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 07:25:07.910115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 07:25:07.910508) ========= 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=ed14279e38b05397cf4aa391000001a4-1461490437.371367-2087051506 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 07:25:07.995998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 07:25:07.996772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 07:25:07.997411) ========= ========= Total master_lag: 0.21 =========