builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1462959032.46 results: success (0) buildid: 20160511021136 builduid: 254861cbfa3d46639248a12daddffbaf revision: 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.455791) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.456208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.456496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.487151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.487436) ========= 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=232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 02:30:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.3M=0s 2016-05-11 02:30:34 (60.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144132 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.645043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.646533) ========= 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=232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019098 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.723791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:32.724115) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 --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 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 --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=232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 02:30:34,286 truncating revision to first 12 chars 2016-05-11 02:30:34,286 Setting DEBUG logging. 2016-05-11 02:30:34,286 attempt 1/10 2016-05-11 02:30:34,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/52f40a1102ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 02:30:34,542 unpacking tar archive at: fx-team-52f40a1102ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573608 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:33.318884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:33.319192) ========= script_repo_revision: 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:33.319617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:33.319887) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 02:30:33.329581) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-11 02:30:33.329860) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:30:34 INFO - MultiFileLogger online at 20160511 02:30:34 in /builds/slave/test 02:30:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:30:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:30:34 INFO - {'append_to_log': False, 02:30:34 INFO - 'base_work_dir': '/builds/slave/test', 02:30:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:30:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:30:34 INFO - 'branch': 'Fx-Team-Non-PGO', 02:30:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:30:34 INFO - 'config_files': ('talos/linux_config.py',), 02:30:34 INFO - 'default_actions': ('clobber', 02:30:34 INFO - 'read-buildbot-config', 02:30:34 INFO - 'download-and-extract', 02:30:34 INFO - 'populate-webroot', 02:30:34 INFO - 'create-virtualenv', 02:30:34 INFO - 'install', 02:30:34 INFO - 'run-tests'), 02:30:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:30:34 INFO - 'download_minidump_stackwalk': True, 02:30:34 INFO - 'download_symbols': 'ondemand', 02:30:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:30:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:30:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:30:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:30:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:30:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:30:34 INFO - 'installer_path': 'installer.exe', 02:30:34 INFO - 'log_level': 'info', 02:30:34 INFO - 'log_name': 'talos', 02:30:34 INFO - 'log_to_console': True, 02:30:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:30:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:30:34 INFO - 'opt_config_files': (), 02:30:34 INFO - 'pip_index': False, 02:30:34 INFO - 'sps_profile': False, 02:30:34 INFO - 'sps_profile_interval': 0, 02:30:34 INFO - 'suite': 'dromaeojs', 02:30:34 INFO - 'system_bits': '32', 02:30:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:30:34 INFO - 'title': 'talos-linux64-ix-025', 02:30:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:30:34 INFO - 'use_talos_json': True, 02:30:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:30:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:30:34 INFO - 'work_dir': 'build'} 02:30:34 INFO - ##### 02:30:34 INFO - ##### Running clobber step. 02:30:34 INFO - ##### 02:30:34 INFO - Running pre-action listener: _resource_record_pre_action 02:30:34 INFO - Running main action method: clobber 02:30:34 INFO - rmtree: /builds/slave/test/build 02:30:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:30:35 INFO - Running post-action listener: _resource_record_post_action 02:30:35 INFO - ##### 02:30:35 INFO - ##### Finished clobber step (success) 02:30:35 INFO - ##### 02:30:35 INFO - ##### 02:30:35 INFO - ##### Running read-buildbot-config step. 02:30:35 INFO - ##### 02:30:35 INFO - Running pre-action listener: _resource_record_pre_action 02:30:35 INFO - Running main action method: read_buildbot_config 02:30:35 INFO - Using buildbot properties: 02:30:35 INFO - { 02:30:35 INFO - "project": "", 02:30:35 INFO - "product": "firefox", 02:30:35 INFO - "script_repo_revision": "production", 02:30:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:30:35 INFO - "repository": "", 02:30:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:30:35 INFO - "buildid": "20160511021136", 02:30:35 INFO - "pgo_build": "False", 02:30:35 INFO - "basedir": "/builds/slave/test", 02:30:35 INFO - "buildnumber": 1741, 02:30:35 INFO - "slavename": "talos-linux64-ix-025", 02:30:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:30:35 INFO - "platform": "ubuntu64_hw", 02:30:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:30:35 INFO - "branch": "fx-team", 02:30:35 INFO - "repo_path": "integration/fx-team", 02:30:35 INFO - "revision": "52f40a1102ad7c5bf8f463334b37595ecbc5bd73", 02:30:35 INFO - "stage_platform": "linux64", 02:30:35 INFO - "builduid": "254861cbfa3d46639248a12daddffbaf", 02:30:35 INFO - "slavebuilddir": "test" 02:30:35 INFO - } 02:30:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:30:35 INFO - Running post-action listener: _resource_record_post_action 02:30:35 INFO - ##### 02:30:35 INFO - ##### Finished read-buildbot-config step (success) 02:30:35 INFO - ##### 02:30:35 INFO - ##### 02:30:35 INFO - ##### Running download-and-extract step. 02:30:35 INFO - ##### 02:30:35 INFO - Running pre-action listener: _resource_record_pre_action 02:30:35 INFO - Running main action method: download_and_extract 02:30:35 INFO - mkdir: /builds/slave/test/build/tests 02:30:35 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')]} 02:30:35 INFO - https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:30:40 INFO - Downloaded 1361 bytes. 02:30:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:30:40 INFO - Using the following test package requirements: 02:30:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:30:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:30:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:30:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:40 INFO - u'jsshell-linux-x86_64.zip'], 02:30:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:30:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:30:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:30:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:30:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:30:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:30:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:30:40 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')]} 02:30:40 INFO - https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:30:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:30:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:30:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:30:58 INFO - Downloaded 22329481 bytes. 02:30:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:30:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:30:59 INFO - Return code: 0 02:30:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:30:59 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')]} 02:30:59 INFO - https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:30:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:30:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:30:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:30:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:00 INFO - Downloaded 22329481 bytes. 02:31:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:31:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:31:02 INFO - Return code: 0 02:31:02 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')]} 02:31:02 INFO - https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:31:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:31:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:31:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:31:03 INFO - Downloaded 10840152 bytes. 02:31:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:31:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:31:04 INFO - Return code: 0 02:31: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')]} 02:31:04 INFO - https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:31:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:31:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:31:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:31:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:31:05 INFO - Downloaded 54681602 bytes. 02:31:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:31:05 INFO - mkdir: /builds/slave/test/properties 02:31:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:31:05 INFO - Writing to file /builds/slave/test/properties/build_url 02:31:05 INFO - Contents: 02:31:05 INFO - build_url:https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:31:06 INFO - Running post-action listener: _resource_record_post_action 02:31:06 INFO - Running post-action listener: set_extra_try_arguments 02:31:06 INFO - ##### 02:31:06 INFO - ##### Finished download-and-extract step (success) 02:31:06 INFO - ##### 02:31:06 INFO - ##### 02:31:06 INFO - ##### Running populate-webroot step. 02:31:06 INFO - ##### 02:31:06 INFO - Running pre-action listener: _resource_record_pre_action 02:31:06 INFO - Running main action method: populate_webroot 02:31:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:31:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:31:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:31:06 INFO - '--tppagecycles', 02:31:06 INFO - '7'], 02:31:06 INFO - 'tests': ['tsvgm']}}, 02:31:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:31:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:31:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:31:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:31:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:06 INFO - 'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:06 INFO - 'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['damp', 'tps']}, 02:31:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:06 INFO - 'tests': ['damp', 'tps']}, 02:31:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['dromaeo_dom']}, 02:31:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:31:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['a11yr', 02:31:06 INFO - 'ts_paint', 02:31:06 INFO - 'tpaint', 02:31:06 INFO - 'sessionrestore', 02:31:06 INFO - 'sessionrestore_no_auto_restore', 02:31:06 INFO - 'tabpaint']}, 02:31:06 INFO - 'other-e10s': {'tests': ['a11yr', 02:31:06 INFO - 'ts_paint', 02:31:06 INFO - 'tpaint', 02:31:06 INFO - 'sessionrestore', 02:31:06 INFO - 'sessionrestore_no_auto_restore', 02:31:06 INFO - 'tabpaint']}, 02:31:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:31:06 INFO - 'ts_paint', 02:31:06 INFO - 'tpaint', 02:31:06 INFO - 'sessionrestore', 02:31:06 INFO - 'sessionrestore_no_auto_restore', 02:31:06 INFO - 'tabpaint']}, 02:31:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:31:06 INFO - 'ts_paint', 02:31:06 INFO - 'tpaint', 02:31:06 INFO - 'sessionrestore', 02:31:06 INFO - 'sessionrestore_no_auto_restore', 02:31:06 INFO - 'tabpaint']}, 02:31:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['a11yr', 02:31:06 INFO - 'ts_paint', 02:31:06 INFO - 'tpaint', 02:31:06 INFO - 'sessionrestore', 02:31:06 INFO - 'sessionrestore_no_auto_restore', 02:31:06 INFO - 'tabpaint']}, 02:31:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['a11yr', 02:31:06 INFO - 'ts_paint', 02:31:06 INFO - 'tpaint', 02:31:06 INFO - 'sessionrestore', 02:31:06 INFO - 'sessionrestore_no_auto_restore', 02:31:06 INFO - 'tabpaint']}, 02:31:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['tsvgx', 02:31:06 INFO - 'tsvgr_opacity', 02:31:06 INFO - 'tart', 02:31:06 INFO - 'tscrollx', 02:31:06 INFO - 'cart']}, 02:31:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:31:06 INFO - 'tsvgr_opacity', 02:31:06 INFO - 'tart', 02:31:06 INFO - 'tscrollx', 02:31:06 INFO - 'cart']}, 02:31:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:06 INFO - 'talos_options': ['--disable-e10s'], 02:31:06 INFO - 'tests': ['tp5o']}, 02:31:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:06 INFO - 'tests': ['tp5o']}, 02:31:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:06 INFO - 'talos_options': ['--disable-e10s', 02:31:06 INFO - '--xperf_path', 02:31:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:06 INFO - 'tests': ['tp5n']}, 02:31:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:31:06 INFO - 'talos_options': ['--xperf_path', 02:31:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:06 INFO - 'tests': ['tp5n']}}, 02:31:06 INFO - 'talos.zip': {'path': '', 02:31:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:31:06 INFO - Running post-action listener: _resource_record_post_action 02:31:06 INFO - ##### 02:31:06 INFO - ##### Finished populate-webroot step (success) 02:31:06 INFO - ##### 02:31:06 INFO - ##### 02:31:06 INFO - ##### Running create-virtualenv step. 02:31:06 INFO - ##### 02:31:06 INFO - Running pre-action listener: _resource_record_pre_action 02:31:06 INFO - Running main action method: create_virtualenv 02:31:06 INFO - Creating virtualenv /builds/slave/test/build/venv 02:31:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:31:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:31:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:31:06 INFO - Using real prefix '/usr' 02:31:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:31:06 INFO - Installing distribute.............................................................................................................................................................................................done. 02:31:08 INFO - Installing pip.................done. 02:31:08 INFO - Return code: 0 02:31:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:31:08 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')]} 02:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:08 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')]} 02:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:08 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 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:08 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 02:31:08 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 02:31:08 INFO - Using env: {'DISPLAY': ':0', 02:31:08 INFO - 'HOME': '/home/cltbld', 02:31:08 INFO - 'LANG': 'en_US.UTF-8', 02:31:08 INFO - 'LANGUAGE': 'en_US:en', 02:31:08 INFO - 'LOGNAME': 'cltbld', 02:31:08 INFO - 'MAIL': '/var/mail/cltbld', 02:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:08 INFO - 'MOZ_NO_REMOTE': '1', 02:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:08 INFO - 'NO_EM_RESTART': '1', 02:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:08 INFO - 'PWD': '/builds/slave/test', 02:31:08 INFO - 'SHELL': '/bin/bash', 02:31:08 INFO - 'SHLVL': '1', 02:31:08 INFO - 'TERM': 'linux', 02:31:08 INFO - 'TMOUT': '86400', 02:31:08 INFO - 'USER': 'cltbld', 02:31:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:08 INFO - '_': '/tools/buildbot/bin/python'} 02:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:31:09 INFO - Cleaning up... 02:31:09 INFO - Return code: 0 02:31:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:31:09 INFO - Using env: {'DISPLAY': ':0', 02:31:09 INFO - 'HOME': '/home/cltbld', 02:31:09 INFO - 'LANG': 'en_US.UTF-8', 02:31:09 INFO - 'LANGUAGE': 'en_US:en', 02:31:09 INFO - 'LOGNAME': 'cltbld', 02:31:09 INFO - 'MAIL': '/var/mail/cltbld', 02:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:09 INFO - 'MOZ_NO_REMOTE': '1', 02:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:09 INFO - 'NO_EM_RESTART': '1', 02:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:09 INFO - 'PWD': '/builds/slave/test', 02:31:09 INFO - 'SHELL': '/bin/bash', 02:31:09 INFO - 'SHLVL': '1', 02:31:09 INFO - 'TERM': 'linux', 02:31:09 INFO - 'TMOUT': '86400', 02:31:09 INFO - 'USER': 'cltbld', 02:31:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:09 INFO - '_': '/tools/buildbot/bin/python'} 02:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:09 INFO - Downloading/unpacking psutil>=0.7.1 02:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:31:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:11 INFO - Installing collected packages: psutil 02:31:11 INFO - Running setup.py install for psutil 02:31:11 INFO - building 'psutil._psutil_linux' extension 02:31:11 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 02:31:11 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 02:31:11 INFO - building 'psutil._psutil_posix' extension 02:31:11 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 02:31:11 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 02:31:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:11 INFO - Successfully installed psutil 02:31:11 INFO - Cleaning up... 02:31:11 INFO - Return code: 0 02:31:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:31:11 INFO - Using env: {'DISPLAY': ':0', 02:31:11 INFO - 'HOME': '/home/cltbld', 02:31:11 INFO - 'LANG': 'en_US.UTF-8', 02:31:11 INFO - 'LANGUAGE': 'en_US:en', 02:31:11 INFO - 'LOGNAME': 'cltbld', 02:31:11 INFO - 'MAIL': '/var/mail/cltbld', 02:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:11 INFO - 'MOZ_NO_REMOTE': '1', 02:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:11 INFO - 'NO_EM_RESTART': '1', 02:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:11 INFO - 'PWD': '/builds/slave/test', 02:31:11 INFO - 'SHELL': '/bin/bash', 02:31:11 INFO - 'SHLVL': '1', 02:31:11 INFO - 'TERM': 'linux', 02:31:11 INFO - 'TMOUT': '86400', 02:31:11 INFO - 'USER': 'cltbld', 02:31:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:11 INFO - '_': '/tools/buildbot/bin/python'} 02:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:31:14 INFO - Installing collected packages: mozsystemmonitor 02:31:14 INFO - Running setup.py install for mozsystemmonitor 02:31:14 INFO - Successfully installed mozsystemmonitor 02:31:14 INFO - Cleaning up... 02:31:14 INFO - Return code: 0 02:31:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:31:14 INFO - Using env: {'DISPLAY': ':0', 02:31:14 INFO - 'HOME': '/home/cltbld', 02:31:14 INFO - 'LANG': 'en_US.UTF-8', 02:31:14 INFO - 'LANGUAGE': 'en_US:en', 02:31:14 INFO - 'LOGNAME': 'cltbld', 02:31:14 INFO - 'MAIL': '/var/mail/cltbld', 02:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:14 INFO - 'MOZ_NO_REMOTE': '1', 02:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:14 INFO - 'NO_EM_RESTART': '1', 02:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:14 INFO - 'PWD': '/builds/slave/test', 02:31:14 INFO - 'SHELL': '/bin/bash', 02:31:14 INFO - 'SHLVL': '1', 02:31:14 INFO - 'TERM': 'linux', 02:31:14 INFO - 'TMOUT': '86400', 02:31:14 INFO - 'USER': 'cltbld', 02:31:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:14 INFO - '_': '/tools/buildbot/bin/python'} 02:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:14 INFO - Downloading/unpacking blobuploader==1.2.4 02:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:16 INFO - Downloading blobuploader-1.2.4.tar.gz 02:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:31:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:31:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:17 INFO - Downloading docopt-0.6.1.tar.gz 02:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:31:17 INFO - Installing collected packages: blobuploader, requests, docopt 02:31:17 INFO - Running setup.py install for blobuploader 02:31:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:31:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:31:17 INFO - Running setup.py install for requests 02:31:17 INFO - Running setup.py install for docopt 02:31:17 INFO - Successfully installed blobuploader requests docopt 02:31:17 INFO - Cleaning up... 02:31:17 INFO - Return code: 0 02:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31: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')]} 02:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31: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')]} 02:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:17 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 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:17 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 02:31:17 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 02:31:17 INFO - Using env: {'DISPLAY': ':0', 02:31:17 INFO - 'HOME': '/home/cltbld', 02:31:17 INFO - 'LANG': 'en_US.UTF-8', 02:31:17 INFO - 'LANGUAGE': 'en_US:en', 02:31:17 INFO - 'LOGNAME': 'cltbld', 02:31:17 INFO - 'MAIL': '/var/mail/cltbld', 02:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:17 INFO - 'MOZ_NO_REMOTE': '1', 02:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:17 INFO - 'NO_EM_RESTART': '1', 02:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:17 INFO - 'PWD': '/builds/slave/test', 02:31:17 INFO - 'SHELL': '/bin/bash', 02:31:17 INFO - 'SHLVL': '1', 02:31:17 INFO - 'TERM': 'linux', 02:31:17 INFO - 'TMOUT': '86400', 02:31:17 INFO - 'USER': 'cltbld', 02:31:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:17 INFO - '_': '/tools/buildbot/bin/python'} 02:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:18 INFO - Running setup.py (path:/tmp/pip-PmhKbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:18 INFO - Running setup.py (path:/tmp/pip-SDJLzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:18 INFO - Running setup.py (path:/tmp/pip-pvmAgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:31:18 INFO - Running setup.py (path:/tmp/pip-ZfzjaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:31:18 INFO - Running setup.py (path:/tmp/pip-9rYzmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:31:18 INFO - Running setup.py (path:/tmp/pip-5IkDfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:31:18 INFO - Running setup.py (path:/tmp/pip-JBDxVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:31:18 INFO - Running setup.py (path:/tmp/pip-k6DbOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:31:18 INFO - Running setup.py (path:/tmp/pip-OgZ0ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:31:18 INFO - Running setup.py (path:/tmp/pip-DYOa0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:31:18 INFO - Running setup.py (path:/tmp/pip-ZYN9aN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:31:18 INFO - Running setup.py (path:/tmp/pip-dJX7V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:31:18 INFO - Running setup.py (path:/tmp/pip-m75Gch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:31:18 INFO - Running setup.py (path:/tmp/pip-WhWMnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:19 INFO - Running setup.py (path:/tmp/pip-Fs5SCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:31:19 INFO - Running setup.py (path:/tmp/pip-JoFRqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:31:19 INFO - Running setup.py (path:/tmp/pip-y95dFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:31:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:31:19 INFO - Running setup.py install for manifestparser 02:31:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:31:19 INFO - Running setup.py install for mozcrash 02:31:19 INFO - Running setup.py install for mozdebug 02:31:19 INFO - Running setup.py install for mozdevice 02:31:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:31:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:31:19 INFO - Running setup.py install for mozfile 02:31:19 INFO - Running setup.py install for mozhttpd 02:31:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:31:19 INFO - Running setup.py install for mozinfo 02:31:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:31:19 INFO - Running setup.py install for mozInstall 02:31:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Running setup.py install for mozleak 02:31:20 INFO - Running setup.py install for mozlog 02:31:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Running setup.py install for moznetwork 02:31:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Running setup.py install for mozprocess 02:31:20 INFO - Running setup.py install for mozprofile 02:31:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Running setup.py install for mozrunner 02:31:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Running setup.py install for mozscreenshot 02:31:20 INFO - Running setup.py install for moztest 02:31:20 INFO - Running setup.py install for mozversion 02:31:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:31:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:31:20 INFO - Cleaning up... 02:31:21 INFO - Return code: 0 02:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:31:21 INFO - Using env: {'DISPLAY': ':0', 02:31:21 INFO - 'HOME': '/home/cltbld', 02:31:21 INFO - 'LANG': 'en_US.UTF-8', 02:31:21 INFO - 'LANGUAGE': 'en_US:en', 02:31:21 INFO - 'LOGNAME': 'cltbld', 02:31:21 INFO - 'MAIL': '/var/mail/cltbld', 02:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:21 INFO - 'MOZ_NO_REMOTE': '1', 02:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:21 INFO - 'NO_EM_RESTART': '1', 02:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:21 INFO - 'PWD': '/builds/slave/test', 02:31:21 INFO - 'SHELL': '/bin/bash', 02:31:21 INFO - 'SHLVL': '1', 02:31:21 INFO - 'TERM': 'linux', 02:31:21 INFO - 'TMOUT': '86400', 02:31:21 INFO - 'USER': 'cltbld', 02:31:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:21 INFO - '_': '/tools/buildbot/bin/python'} 02:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:21 INFO - Running setup.py (path:/tmp/pip-nRE8OH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:21 INFO - Running setup.py (path:/tmp/pip-XpLvBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:21 INFO - Running setup.py (path:/tmp/pip-sPMBPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:31:21 INFO - Running setup.py (path:/tmp/pip-wbxuQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:31:21 INFO - Running setup.py (path:/tmp/pip-NKQSxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:31:21 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)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:31:21 INFO - Running setup.py (path:/tmp/pip-_UHpfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:31:21 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)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:31:21 INFO - Running setup.py (path:/tmp/pip-2YAaj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:31:21 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)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:31:21 INFO - Running setup.py (path:/tmp/pip-Iod9p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:31:21 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)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:31:21 INFO - Running setup.py (path:/tmp/pip-I50OGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:31:21 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)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:31:21 INFO - Running setup.py (path:/tmp/pip-n4GqRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:31:21 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)) 02:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:31:21 INFO - Running setup.py (path:/tmp/pip-3AY2AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:31:22 INFO - Running setup.py (path:/tmp/pip-wqSHIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:31:22 INFO - Running setup.py (path:/tmp/pip-Iwa9IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:31:22 INFO - Running setup.py (path:/tmp/pip-uOWzIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:22 INFO - Running setup.py (path:/tmp/pip-b2NpON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:31:22 INFO - Running setup.py (path:/tmp/pip-YaXBun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:31:22 INFO - Running setup.py (path:/tmp/pip-XQaebD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:31:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:24 INFO - Downloading blessings-1.6.tar.gz 02:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:31:24 INFO - Installing collected packages: blessings 02:31:24 INFO - Running setup.py install for blessings 02:31:24 INFO - Successfully installed blessings 02:31:24 INFO - Cleaning up... 02:31:24 INFO - Return code: 0 02:31:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:24 INFO - Reading from file tmpfile_stdout 02:31:24 INFO - Current package versions: 02:31:24 INFO - argparse == 1.2.1 02:31:24 INFO - blessings == 1.6 02:31:24 INFO - blobuploader == 1.2.4 02:31:24 INFO - docopt == 0.6.1 02:31:24 INFO - manifestparser == 1.1 02:31:24 INFO - mozInstall == 1.12 02:31:24 INFO - mozcrash == 0.17 02:31:24 INFO - mozdebug == 0.1 02:31:24 INFO - mozdevice == 0.48 02:31:24 INFO - mozfile == 1.2 02:31:24 INFO - mozhttpd == 0.7 02:31:24 INFO - mozinfo == 0.9 02:31:24 INFO - mozleak == 0.1 02:31:24 INFO - mozlog == 3.1 02:31:24 INFO - moznetwork == 0.27 02:31:24 INFO - mozprocess == 0.22 02:31:24 INFO - mozprofile == 0.28 02:31:24 INFO - mozrunner == 6.11 02:31:24 INFO - mozscreenshot == 0.1 02:31:24 INFO - mozsystemmonitor == 0.0 02:31:24 INFO - moztest == 0.7 02:31:24 INFO - mozversion == 1.4 02:31:24 INFO - psutil == 3.1.1 02:31:24 INFO - requests == 1.2.3 02:31:24 INFO - wsgiref == 0.1.2 02:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:24 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')]} 02:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:24 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')]} 02:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:24 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 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:24 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 02:31:24 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 02:31:24 INFO - Using env: {'DISPLAY': ':0', 02:31:24 INFO - 'HOME': '/home/cltbld', 02:31:24 INFO - 'LANG': 'en_US.UTF-8', 02:31:24 INFO - 'LANGUAGE': 'en_US:en', 02:31:24 INFO - 'LOGNAME': 'cltbld', 02:31:24 INFO - 'MAIL': '/var/mail/cltbld', 02:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:24 INFO - 'MOZ_NO_REMOTE': '1', 02:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:24 INFO - 'NO_EM_RESTART': '1', 02:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:24 INFO - 'PWD': '/builds/slave/test', 02:31:24 INFO - 'SHELL': '/bin/bash', 02:31:24 INFO - 'SHLVL': '1', 02:31:24 INFO - 'TERM': 'linux', 02:31:24 INFO - 'TMOUT': '86400', 02:31:24 INFO - 'USER': 'cltbld', 02:31:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:24 INFO - '_': '/tools/buildbot/bin/python'} 02:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 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)) 02:31:24 INFO - Cleaning up... 02:31:24 INFO - Return code: 0 02:31:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:31:24 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')]} 02:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:24 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')]} 02:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:24 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 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:24 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 02:31:24 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 02:31:24 INFO - Using env: {'DISPLAY': ':0', 02:31:24 INFO - 'HOME': '/home/cltbld', 02:31:25 INFO - 'LANG': 'en_US.UTF-8', 02:31:25 INFO - 'LANGUAGE': 'en_US:en', 02:31:25 INFO - 'LOGNAME': 'cltbld', 02:31:25 INFO - 'MAIL': '/var/mail/cltbld', 02:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:25 INFO - 'MOZ_NO_REMOTE': '1', 02:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:25 INFO - 'NO_EM_RESTART': '1', 02:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:25 INFO - 'PWD': '/builds/slave/test', 02:31:25 INFO - 'SHELL': '/bin/bash', 02:31:25 INFO - 'SHLVL': '1', 02:31:25 INFO - 'TERM': 'linux', 02:31:25 INFO - 'TMOUT': '86400', 02:31:25 INFO - 'USER': 'cltbld', 02:31:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:25 INFO - '_': '/tools/buildbot/bin/python'} 02:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:25 INFO - Downloading/unpacking jsonschema 02:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:31:27 INFO - Downloading/unpacking functools32 (from jsonschema) 02:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:31:27 INFO - warning: no files found matching '*.txt' 02:31:27 INFO - no previously-included directories found matching 'build' 02:31:27 INFO - no previously-included directories found matching 'dist' 02:31:27 INFO - no previously-included directories found matching '.git*' 02:31:27 INFO - Installing collected packages: jsonschema, functools32 02:31:27 INFO - Running setup.py install for functools32 02:31:27 INFO - warning: no files found matching '*.txt' 02:31:27 INFO - no previously-included directories found matching 'build' 02:31:27 INFO - no previously-included directories found matching 'dist' 02:31:27 INFO - no previously-included directories found matching '.git*' 02:31:27 INFO - Successfully installed jsonschema functools32 02:31:27 INFO - Cleaning up... 02:31:27 INFO - Return code: 0 02:31:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:31:27 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')]} 02:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:27 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')]} 02:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:27 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 0x7f5dc6a65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, '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': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', '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 02:31:27 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 02:31:27 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 02:31:27 INFO - Using env: {'DISPLAY': ':0', 02:31:27 INFO - 'HOME': '/home/cltbld', 02:31:27 INFO - 'LANG': 'en_US.UTF-8', 02:31:27 INFO - 'LANGUAGE': 'en_US:en', 02:31:27 INFO - 'LOGNAME': 'cltbld', 02:31:27 INFO - 'MAIL': '/var/mail/cltbld', 02:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:27 INFO - 'MOZ_NO_REMOTE': '1', 02:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:27 INFO - 'NO_EM_RESTART': '1', 02:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:27 INFO - 'PWD': '/builds/slave/test', 02:31:27 INFO - 'SHELL': '/bin/bash', 02:31:27 INFO - 'SHLVL': '1', 02:31:27 INFO - 'TERM': 'linux', 02:31:27 INFO - 'TMOUT': '86400', 02:31:27 INFO - 'USER': 'cltbld', 02:31:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:27 INFO - '_': '/tools/buildbot/bin/python'} 02:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:27 INFO - Downloading/unpacking flake8 02:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:31:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:31:29 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 02:31:29 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 02:31:29 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 02:31:29 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 02:31:29 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 02:31:29 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 02:31:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:31:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:31:29 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 02:31:29 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 02:31:29 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 02:31:29 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 02:31:29 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 02:31:29 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 02:31:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:31:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:31:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:31:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:31:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:31:30 INFO - no previously-included directories found matching 'docs/_build' 02:31:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:31:30 INFO - Running setup.py install for pep8 02:31:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:31:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:31:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:31:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:31:30 INFO - no previously-included directories found matching 'docs/_build' 02:31:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:31:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:31:30 INFO - Cleaning up... 02:31:30 INFO - Return code: 0 02:31:30 INFO - Running post-action listener: _resource_record_post_action 02:31:30 INFO - Running post-action listener: _start_resource_monitoring 02:31:30 INFO - Starting resource monitoring. 02:31:30 INFO - ##### 02:31:30 INFO - ##### Finished create-virtualenv step (success) 02:31:30 INFO - ##### 02:31:30 INFO - ##### 02:31:30 INFO - ##### Running install step. 02:31:30 INFO - ##### 02:31:30 INFO - Running pre-action listener: _resource_record_pre_action 02:31:30 INFO - Running main action method: install 02:31:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:30 INFO - Reading from file tmpfile_stdout 02:31:30 INFO - Detecting whether we're running mozinstall >=1.0... 02:31:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:31:30 INFO - Reading from file tmpfile_stdout 02:31:30 INFO - Output received: 02:31:30 INFO - Usage: mozinstall [options] installer 02:31:30 INFO - Options: 02:31:30 INFO - -h, --help show this help message and exit 02:31:30 INFO - -d DEST, --destination=DEST 02:31:30 INFO - Directory to install application into. [default: 02:31:30 INFO - "/builds/slave/test"] 02:31:30 INFO - --app=APP Application being installed. [default: firefox] 02:31:30 INFO - mkdir: /builds/slave/test/build/application 02:31:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:31:46 INFO - Reading from file tmpfile_stdout 02:31:46 INFO - Output received: 02:31:46 INFO - /builds/slave/test/build/application/firefox/firefox 02:31:46 INFO - Running post-action listener: _resource_record_post_action 02:31:46 INFO - ##### 02:31:46 INFO - ##### Finished install step (success) 02:31:46 INFO - ##### 02:31:46 INFO - ##### 02:31:46 INFO - ##### Running run-tests step. 02:31:46 INFO - ##### 02:31:46 INFO - Running pre-action listener: _resource_record_pre_action 02:31:46 INFO - Running main action method: run_tests 02:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:31:46 INFO - Python 2.7.3 02:31:46 INFO - Return code: 0 02:31:46 INFO - grabbing minidump binary from tooltool 02:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:31:46 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13869c0>, '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 0x13878c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:31:46 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 02:31:46 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 02:31:46 INFO - Calling ['/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'] with output_timeout 600 02:31:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:31:46 INFO - Return code: 0 02:31:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:31:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:31:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:31:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:31:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:31:47 INFO - Return code: 0 02:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:31:47 INFO - Using env: {'DISPLAY': ':0', 02:31:47 INFO - 'HOME': '/home/cltbld', 02:31:47 INFO - 'LANG': 'en_US.UTF-8', 02:31:47 INFO - 'LANGUAGE': 'en_US:en', 02:31:47 INFO - 'LOGNAME': 'cltbld', 02:31:47 INFO - 'MAIL': '/var/mail/cltbld', 02:31:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:31:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:47 INFO - 'MOZ_NO_REMOTE': '1', 02:31:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:47 INFO - 'NO_EM_RESTART': '1', 02:31:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:47 INFO - 'PWD': '/builds/slave/test', 02:31:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:31:47 INFO - 'SHELL': '/bin/bash', 02:31:47 INFO - 'SHLVL': '1', 02:31:47 INFO - 'TERM': 'linux', 02:31:47 INFO - 'TMOUT': '86400', 02:31:47 INFO - 'USER': 'cltbld', 02:31:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787', 02:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:47 INFO - '_': '/tools/buildbot/bin/python'} 02:31:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:31:47 INFO - mozversion application_buildid: 20160511021136 02:31:47 INFO - mozversion application_changeset: 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 02:31:47 INFO - mozversion application_display_name: Nightly 02:31:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:31:47 INFO - mozversion application_name: Firefox 02:31:47 INFO - mozversion application_remotingname: firefox 02:31:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:31:47 INFO - mozversion application_vendor: Mozilla 02:31:47 INFO - mozversion application_version: 49.0a1 02:31:47 INFO - mozversion platform_buildid: 20160511021136 02:31:47 INFO - mozversion platform_changeset: 52f40a1102ad7c5bf8f463334b37595ecbc5bd73 02:31:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:31:47 INFO - mozversion platform_version: 49.0a1 02:31:47 INFO - using testdate: 1462959107 02:31:47 INFO - actual date: 1462959107 02:31:47 INFO - starting webserver on 'localhost:48400' 02:31:47 INFO - SUITE-START | Running 2 tests 02:31:47 INFO - TEST-START | dromaeo_css 02:31:47 INFO - operating with platform_type : linux_ 02:31:47 INFO - Initialising browser for dromaeo_css test... 02:31:47 INFO - TEST-INFO | started process 9240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYlFTOp/profile http://localhost:48400/getInfo.html) 02:31:52 INFO - PROCESS | 9240 | __metrics Screen width/height:1600/1200 02:31:52 INFO - PROCESS | 9240 | colorDepth:24 02:31:52 INFO - PROCESS | 9240 | Browser inner width/height: 1024/697 02:31:52 INFO - PROCESS | 9240 | __metrics 02:31:53 ERROR - PROCESS | 9240 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:31:54 INFO - TEST-INFO | 9240: exit 0 02:31:54 INFO - Browser initialized. 02:31:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:31:54 INFO - TEST-INFO | started process 9321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYlFTOp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:06 INFO - PROCESS | 9321 | RSS: Main: 153608192 02:32:06 INFO - PROCESS | 9321 | 02:32:57 INFO - PROCESS | 9321 | 1462959177101 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] 02:35:09 INFO - PROCESS | 9321 | Cycle 1(1): loaded http://localhost:48400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48400/tests/dromaeo/cssquery-ext.html) 02:35:10 INFO - PROCESS | 9321 | RSS: Main: 246407168 02:35:10 INFO - PROCESS | 9321 | 02:38:13 INFO - PROCESS | 9321 | Cycle 1(1): loaded http://localhost:48400/tests/dromaeo/cssquery-ext.html (next: http://localhost:48400/tests/dromaeo/cssquery-jquery.html) 02:38:13 INFO - PROCESS | 9321 | RSS: Main: 237514752 02:38:13 INFO - PROCESS | 9321 | 02:41:15 INFO - PROCESS | 9321 | Cycle 1(1): loaded http://localhost:48400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48400/tests/dromaeo/cssquery-mootools.html) 02:41:16 INFO - PROCESS | 9321 | RSS: Main: 236462080 02:41:16 INFO - PROCESS | 9321 | 02:44:18 INFO - PROCESS | 9321 | Cycle 1(1): loaded http://localhost:48400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48400/tests/dromaeo/cssquery-prototype.html) 02:44:19 INFO - PROCESS | 9321 | RSS: Main: 231714816 02:44:19 INFO - PROCESS | 9321 | 02:47:22 INFO - PROCESS | 9321 | Cycle 1(1): loaded http://localhost:48400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48400/tests/dromaeo/cssquery-yui.html) 02:47:22 INFO - PROCESS | 9321 | RSS: Main: 206413824 02:47:22 INFO - PROCESS | 9321 | 02:50:25 INFO - PROCESS | 9321 | Cycle 1(1): loaded http://localhost:48400/tests/dromaeo/cssquery-yui.html (next: http://localhost:48400/tests/dromaeo/cssquery-dojo.html) 02:50:26 INFO - PROCESS | 9321 | RSS: Main: 266477568 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - PROCESS | 9321 | __start_tp_report 02:50:26 INFO - PROCESS | 9321 | _x_x_mozilla_page_load 02:50:26 INFO - PROCESS | 9321 | _x_x_mozilla_page_load_details 02:50:26 INFO - PROCESS | 9321 | |i|pagename|runs| 02:50:26 INFO - PROCESS | 9321 | |0;dojo.html;2618.5155746186956;2634.196570046135;2677.8661066946647;2680.2897232233463;2688.1801050679546;4598.724076555405;4677.883052923678;4679.602233810122;4720.8583742487735;4732.36113124728;4709.987352719165;4740.431148262213;4743.976280118603;4765.380500534934;4780.9760951195285;4293.7209081409765;4313.2020576193345;4382.189294980439;4407.80164892579;4419.11617676466;4407.82368705253;4457.264551349023;4473.88815279619;4489.259272220096;4500.97749511252;4228;4261.808218630169;4266.146770645883;4390.056137930328;4411.228035093862;4279.486461624594;4297.871063868089;4298.849540266107;4300.548442413564;4301.247281725686;4282.828686852522;4315.244832154361;4318.352247162919;4359.520452750195;4383.145286669101;4687.39063921688;4692.718436893797;4700.647451441156;4752.310914917352;4764.714117152947;5130.666506677054;5133.050385678662;5136.383633963948;5167.4057483389515;5177.042247184283;5026.824061157842;5088.745562721849;5152.227165925104;5158.226266060084;5231.607629427808;4827.300041494034;4838.322634831126;4845.95154048455;4880.219164933594;4894.045661096052;5137.794488220429;5301.655392399482;5335.093034184198;5338.519533241949;5348.3849357323625;4876.268559716071;4915.508449155056;4915.992221594564;4957.801687932442;4977.32806071183;5000.1249781288125;5004.899902002013;5006.048850718352;5008.198688209869;5042.621803364762;4910.091633047826;4946.208606622923;4949.975250123726;4956.3804524434445;4996.150654388763;4879.1461494238365;4934.753262336941;4944.802207911715;4948.529889660476;4986.650934434628;4228.471441069866;4233.661307095425;4258.190943720683;4266.189424009428;4271.700980931305;3718.3492888744363;3731.645493678096;3763.303788799081;3778.282126396031;3779.4708740776314;4257.23369793434;4294.441722576045;4354.172707185625;4360.912781744348;4361.280388735887;5137.8715532112;5142.6914385137015;5146.614003949644;5170.17277235648;5213.817516386908;4266.1254442839145;4346.782660866944;4359.367891655692;4362.367456718822;4408.559144085566;4560.065186636732;4617.653675974316;4640.559146881041;4651.4418269807165;4660.883477913079;4814.398200224972;4843.2250839865455;4845.63657725665;4847.297141914332;4895.779689913891;4997.400311962588;5061.595072394126;5144.562712169508;5155.845324640267;5209.609279303992;4771.928421073756;4786.904261914672;4808.591269742111;4809.110314591811;4852.636052296162;5018.4981501849525;5029.7988080477835;5030.647854650139;5033.773480193327;5080.796768129233;4930.827421040246;5041.092603331289;5062.645614806928;5089.236614507853;5097.337346144977;4924.064427758714;4929.9014019720125;4940.75296235194;4944.035912996931;4967.7019378837385;4942.308076869169;4947.01059788051;4948.084604348207;4950.430700469348;4983.476734942778;4724.503927087606;4802;4818.494058123846;4829.492903245108;4910.042541704476;4940;4956.281339205867;4970.229614409773;4984.8753781155765;5007.574356179765;4851.51484851512;4853.563179313879;4857.732824694675;4863.270509423614;4921.237208232729 02:50:26 INFO - PROCESS | 9321 | |1;ext.html;574.4657468554245;599.3766482857828;612.161338965617;615.6183166436809;630.4074170279933;27034.5944810828;41930.58069419305;43069.56930430691;43073;43122;42228.94427639311;42763;42910;42921;42923.35614965778;7434.256574342577;7897.289243968042;8003.4797738146835;9975.650852220173;10245;10079.193664506858;10129.189664826834;10164.898351016505;10172.491375431237;10188.490575471234;10210.336328138685;10252.846207306897;10258.23063270254;10259.794804103913;10262.435566043865;7555.659995300197;10001.399916005026;10317.638882639147;10320.225983051227;10598.152147828156;10112.191024718006;10169.644062457852;10177.338472999232;10178.338408003456;10189.490525473697;38994.80502597469;39144.608553914666;39195;39256.41115383243;39259;3271.7219036381935;3291.1607540077125;3328.700416962485;3336.9332613347597;3402.319536092791;30057.248568785737;30335;30458;30473.847630761928;30906.53640195399;3086.0486951856356;3097.845107744626;3144.827034513101;3163.6678148794276;3201.119692084672;175801;176397;176751;177011;177466;34842.82578587091;56107.71946140325;56324.71837640786;56472.71763641156;56507.43492565104;34228.315433691685;35917.46123808145;36159.638403616154;36167.638323616426;36193.81903090468;11278.605248816251;12677.746445071047;12826.038047146501;12855.164414313227;12866.421011054525;10345.896541034645;10599.470026498644;10634.734131646615;10819.404932728617;10875.075618572351;8363.330933525303;8375.581220938928;8412.957935210407;8440.873386899202;8476.36427267945;3106.254498920288;3118.922026949299;3133.686631336848;3143.2927591291777;3180.173154979722;916.2532535983286;924.2652091587204;937.3672770879629;1077.8059949209219;1086.5056399338282;29099.41801163965;29795.255118621775;31038.05138511838;31752.364952700817;33295.334093318;983.1937810995058;1023.125227930124;1042.4527123260198;1087.923845330835;1088.472091035847;15110.773338399713;15458.768118478232;15497.690046199239;15591.454299099478;15695.764563531557;352107;352538;354807;356223;356252;50149;50310.49689503131;50425.24362134571;50430.96552275809;50598.49401506012;1164.8310994905692;1251.0929576057285;1289.9032572557096;1306.0726883912528;1322.9338533073114;27073.45853082888;30142.246443839078;30211;30238.69761302359;30815;44635.553644463136;45114.548854512344;45400.77299613481;45450.31824522701;45626.31560526661;321815;326784;327394;327562;328181;34696.653033469345;35621.643783561834;40508;41324.58675413328;41437.79281103575;42690;43220.13559728725;43239.35140972951;43843;44069.559304406546;36792.63207367892;37608.247835042595;37625.81187094047;37666.811665941495;38381.6161838378;36858.63141368659;36930.44604330883;37490.625093749804;37603.24793504169;37633.81183094067;36107.45838812472;36706;37040.259194815415;37111.81444092762;37197.814010929775;29516;29777.553336699533;30189;30214.69785302207;30276.84861575678;25304.620430693187;25894.741052589234;25947;25957.74042259629;26305.342366440993 02:50:26 INFO - PROCESS | 9321 | |2;jquery.html;371.305658418757;386.76407391491205;390.60743952327914;391.13949311514665;399.4507552115839;15845.286962086704;17588.736168957443;17793.7330940036;17826.108694565268;17826.910865445672;16851.74722379165;16866.325346986105;17102.572435689115;17608.295668173258;17638.91180544099;4825.348577941977;4988.5260900214425;5221.399539053001;5231.973840130794;5271.604629652772;3668.963310366889;4631.93052104217;5917.20117784098;5929.88140237195;6057.575969682124;5920.111983202532;5959.225300710901;5970.97014514929;6088.695565221721;6095.939040609604;5823.417658234185;6077.513798896078;6079.544034197431;6084.178635884144;6089.817305480843;4674.555917187896;5331.760070796823;5334.679919204821;5335.973320133413;5337.973310133424;12223.449944752507;12290.877091229153;12365.31990740509;12384.256944583354;12429;2062.5668609592003;2086.926957556478;2200;2354.9638159209894;2393.916212932539;9122.315826312986;9259.814803703888;9450;9544.761380965461;10940.3982780947;1757.613325068483;1757.9208935597928;1773.7516747655338;1796.8203179681927;1831.8992455414948;71482;74312.62843685801;74995.62502187454;75278.62360688162;76358.6182069086;10434.68695939123;10496.212784041074;10518.632577764842;10836.187285953427;10901.83647245292;14583.92708036453;14665.853341466449;14698.63253418673;14707.779383309258;14713.779293310608;7282.198958114604;7483.775486735407;7497.850042999109;7593.620318984029;7632.961835190788;6983.720651173998;7013.6142512161305;7134.286571342825;7137;7268.709251629875;4397.076613911115;4454.732716037048;4464.709793863389;4485.529019452911;4598.103369842848;1866.496046067554;1917.6164767046369;1923.2883832981886;1931.4012656076661;1967.704844273342;701.6702149989496;796.5539297993026;889.5507768576956;1002.5538635307219;1014.8883622801486;16195.595110122342;16986;17115.657686846193;17402.82597174012;17413.12934353277;859.3125499600295;879.8548239540404;887.0951629338039;903.701778413122;932.6922115701938;9332.16010559053;9478.905210947802;9578.329516933887;9639.421634701941;9812.754681133028;412111;414212;454074;458484.4151558508;466171;80386.59806701046;86819.56590217008;86901.56549217213;87633.12366876377;88094;925.3984909808544;940.619049285027;951.9762005949768;963.5760265483165;972.4359871274644;15532.844671553139;15809.68380632404;15847.603809904844;16052.3145069766;16315.510534683504;34791.304173916884;35667;35740.4638930411;36915;37214.62785372112;50483.495165047876;51078.48921510737;51883.48116518786;52347.21479177739;52639.73680131575;7202.639868006683;7545.962270188614;7553.509021913558;7732.342750866239;7733.690652373842;10825;11400.258983166068;11586.652400428;11667.883321166679;11721.472533735832;9872.160866326156;10262.914783650906;10293;10345.84481232767;10420.739481512719;9789.9021009789;10250.58997640116;10294.897051029393;10296;10324.122449591869;9901.702948911545;10104.595816167564;10393.844092338772;10592.735181620521;10706.518206680874;7728.26581474759;7966.1237263902085;8001.799955001172;8034.558099304594;8152.307053900485;7888.408369372435;9675.70972870815;10608.946955265174;10663.360198388122;10861.348319100563 02:50:26 INFO - PROCESS | 9321 | |3;mootools.html;1313.3892739875955;1517.8330383657797;1534.2175490499844;1704.727243641017;1902.952426189346;6664.533482656216;7630.351420129289;7880.133185349607;7900.8814867776955;8127.5529845858455;7862.803429914241;8014.358851291897;8036.2365575270405;8042.638081286342;8043;1848.4916647921862;2156.406988078283;2208.4147700859285;2210.8784016879067;2240.361496973363;2182.356204919545;2206.205765924266;2206.30501392061;2210.2706106984656;2211.436083798629;2076.6884967254955;2088.1438610169835;2107.1887323380456;2107.862988905724;2108.388567315477;1819.2177363733656;1871.9251229950785;1876.4464482977555;2040.9897950510226;2043.632146213681;2156.9892150539304;2201.119552179141;2203.129763743312;2206.4594174427207;2207.293666026872;7719.575423351714;7772.922270777276;7783.299503044753;7791.883121753178;7825.295723384866;4558.430196225472;4686.53134686532;4689.953100468986;4693.061387722435;4695.859124226278;2698.5547384681504;2809.9016534421403;2811.550151975674;2822.7600653944232;2863.7852161088003;852.5609311204735;858.6908712863365;858.9828203435959;865.5499140446996;871.2159056848824;10871.184661150366;10948.3978381189;10988.890111098946;10989.505472253768;11023.779524409467;4036.0717035082093;4044.8988775280263;4177.185448837508;4180.770057646859;4189.539150693421;9297;9321.860172097424;9340.906590934139;9344;9381.906180938104;4707.223308154116;4709.529047095263;4713.175194340976;4713.434387873477;4718.103560323528;3792.50697409335;4252.87241382759;4350.238708226111;4358.5205627380965;4404.295312749945;3703.9814800925824;3760.511133552621;3774.47157397959;3820.2932457495453;3874.8062596870045;1202.290648517379;1209.498058305811;1214.9028077753758;1224.0268986156027;1235.4008305971597;922.7508572685338;932.7248461703814;935.6771913689767;941.651588912107;968.1722127580957;5488.835334939959;5582.078956972054;5653.80211692597;5741.368449470555;5750.597458177887;861.1087524412203;862.2326129744532;867.5228624256633;906.7642412972675;917.092078841955;3838.1172330364175;3928.626780455852;3945;3951.9012024699614;4010.438538604598;9042.909570904338;9186.63253469867;9417.858732119024;9418.15236628693;9474.38416502925;9330.766730831783;9354.766130846783;9402.482863442576;9437.103475169848;9451.38565993222;7101.928980710127;7103.147622285359;7399.408047356199;7459.477836551498;7515.21090285523;5414.864628384322;5444.428335024765;5449.918251226156;5588;5599.216109744721;8599.785005374915;8755.737327880173;9023.954880225558;9047.411918225294;9196.632134714537;8894.243989260985;9120.315976301936;9169.816603668023;9180.311476639145;9193.034731353111;5902.350741418526;6079.908801368071;6081.1486391906055;6427.068075129174;6519.08732777421;7084.822879428056;7406.444516661164;7558.13081495635;7645.464817462725;7831.804204894923;6962;7056.894146587702;7098.503104782822;7174.139103307636;7213;6724.8991265132045;6963.303669632996;7004.3696067354185;7028.437724981887;7048.436125109876;6268.717907694074;6537.215534135744;6538.574992625464;6576.408123268929;6643.435307998874;4887.535684110004;4930.112579735682;4939.53074457926;4939.937913348647;4964.975175124101;4937.851864444073;4972.8756781080765;4999.082327614072;5007.273945277987;5078.263651770399 02:50:26 INFO - PROCESS | 9321 | |4;prototype.html;318.06330357098346;323.4130053952077;327.16409573539613;330.7288023820468;333.43316362184294;4788.545088216618;4803.183458812006;4829.179039563274;4831.68594041387;4846.878828029301;4713.78787954542;4740.26525888487;4786.348709695149;4787.8324258650955;4789.544993225647;3552.7157827373876;3695.9445608315896;3710.610385909481;3821.9489640348847;3855;3720.665140137387;3771.8491260349692;3808.409696497047;3809.752366096209;3822.3310920588924;3756.1736417988136;3769.208466222097;3779.622037796212;3786.2238241160494;3799.9430008549757;3580.92838143237;3664.725145614076;3758.624137586247;3773.490578771858;3807.5430948286107;3362.9742928406827;3366.663333666638;3381.712554432876;3386.5766779152605;3392.3215356928713;4525.909481810345;4526.569975852289;4535.523770004135;4538.478075021382;4558.746344755185;4214.325707886754;4257.808398622038;4287.799416163448;4311.396404503372;4336.046069864625;4969.055879382941;4978.477259887696;4991.4758950310425;4999.500049994971;5000.274960130797;3666.834992425347;3701.648343407372;3712.535933008374;3714.5542534895717;3717.368047431943;4927.36386033474;5236.423993360727;5238.05714971305;5238.79044838206;5247.947520524822;3668.211334563082;3668.954348010804;3676.566139205712;3698.1679122197293;3702.61122582125;3716.3682174030478;3733.290674771785;3736.813159342022;3745.3071181831447;3763.5483741951143;4226.746395216297;4230.196262710076;4231.513375961804;4245.724027938174;4272.551382104896;4751.64362672801;4970.552650261421;4980.779708971325;5059.696418214919;5071.822486212965;1291.309149604957;1297.9935100324626;1304.6868751499571;1305.778017736987;1309.8100775387516;801.6112185589984;831.6631764135535;867.9001914779755;884.5046773806689;896.462122726359;4261.31818908973;4279.636230920407;4283.635890949242;4314.956850431456;4319.222539942778;5031.195008798648;5064.797408103708;5089.949100509021;5092.159793634083;5093.159628661304;4050.3924411338535;4292.291771857671;4306.698531102793;4319.136172765459;4323.978380108079;2711.30861630283;2730.1536523677723;2740.9177724668293;2742.4515096980685;2745.546984747494;4801.68789028719;4818.8795280118275;4822.107910036654;4843.806247750121;4862.854114376574;4969.776360063805;5169.302144210558;5182.196759502283;5242.554382877498;5255.290535777621;4716.853831506724;4746.240601503743;4752.643551733634;4754.120487709715;4788.233882578771;4970.080535100873;4989.575886049726;5029.572486338702;5060.165072762953;5060.418051924076;4679.438467383936;4930.556249937379;4960.751962401793;4961.5286547777905;4973;4684.6486513510945;4754.762261886823;4758.691359875923;4763.7618119094595;4772.809087636456;3635.4731012974084;3645.1433913029887;3653.853845846136;3671.8984304709015;3694.224212915318;4918.43438004634;5077.466865979019;5091.1854103343285;5097.439281678938;5109.416081014897;4830.830920917751;4846.103470857903;4853.538913803183;4865.513448655106;4868.926966095441;4850.126977144007;4859.392575928009;4865.927011094907;4920.950790492049;4922.138625740409;4510.2783554631105;4755.310479980452;4780.330753694555;4805;4842.7578621068105;4792.616590672668;4867.318575399518;4922.237053256751;4959.305697202467;4974.7512624369365;4852.320675105418;4868.3427737255015;4909.410870695397;4928.507149285187;4997 02:50:26 INFO - PROCESS | 9321 | |5;yui.html;746.9738559150429;779.5868189859373;793.662693355324;806.3670019035052;824.4805772363407;11885.34630595318;12489.750204995895;12492;12495.250284982896;12501.312427816467;11572.594959176431;11605.593804216855;11623.709407264823;11628.476718547665;11630.883691163086;673.2392396591869;827.1521690267464;851.4720873058682;856.1652388920784;856.2465030772943;852.6163226548047;853.3557164340945;855.422589751918;856.374846362156;856.4604299291437;908.8046070094928;911.08436021798;911.5123408976199;911.5624500239888;911.6490151291767;706.1984647425184;887.7603047177258;919.5172534419416;919.5310391700215;923.3259720404076;682.1405029662611;682.7507959594761;683.0914883205324;683.6376720338229;683.8871586188272;11521.654350369503;11531.538738450452;11547.884521154765;11583.420828958602;11593.304401735923;12280.815787763191;12706.74586508274;12717.23696578199;12739.61781146567;13009;10393.53229104692;10815.621453249098;10850.891491085067;11203.21577489576;11348.205625606128;4192.4759405074365;4209.6421804146685;4216.936745948813;4247.321184396999;4331.415258940035;41874.79062604668;42174.156516869494;43609.56390436119;43794.343084853754;44024.339634905504;9327.813443731087;9442.291828112782;9587.712368628952;10212.336198147097;10350.223733219887;17336.133193340283;17441.12794360277;17549.385771498193;17639.82360176382;17650.646987060445;6411.743530258831;6429.3570642936265;6486.44865186455;6528.412442880163;6589.275179730226;3396.864125434955;3425.5718035245595;3456.4642480415578;3504.7546671732734;3593.2993066352333;2683.7182095880044;2779.7915156363356;2781.374190807093;2787.693353731088;2790.8883644654393;448.9506154323022;505.45410956167984;515.9484051594885;517.3920643244173;572.705056895699;587.8295294364672;609.5093449772976;630.0643544336656;630.6846576711645;637.1334984421184;8425.620847061897;8623.956880215559;8755.474671519729;8787.340949428819;8852.601632926406;547.2448021729987;630.9936900630935;637.4135795068548;642.5887432043496;662.8309781005813;3887.3974533947285;4131.35963925592;4148.108156746314;4155.723163225859;4262.87211383659;51793;53823.19265211025;54203;54459;54561.72719136379;47016.5298347019;48410;48822.511774881794;49927.0014599706;50677.23984140241;44958;45158.77420612942;45316.320255196195;45880.3117953231;46284.305735414;7936.920630793849;7970.4022198336515;8067.354611631173;8090.271875531231;8149.840292322658;30652.233694157825;30655.846720766254;30779.538306924966;30814.383712326075;31386.21534461657;35101.64898351086;37750.811245943594;38941;39018.41472377974;39144;9816.165625921876;9983.301168918397;9986.35088719231;10217.23370747182;10288.742781430525;11911.344876031555;11965.222260553037;12049.578264761041;12426.378681066091;12478.625641230414;11234.101271898391;11266.155038371991;11773.587924422603;11781.941090294493;11850.051995840484;11379.54481820718;11532.59635912739;11875.287482751062;11964.162508624313;11974.760504790029;10727.302725322828;11022.944885275523;11238.157138214503;11321.264117832314;11798.646040618794;9307.395019323721;9521.19069879068;9552.522373881138;9692;9805.166560842408;9706;9732.75668108303;9773.853392199266;9809;9849.113579777855 02:50:26 INFO - PROCESS | 9321 | __end_tp_report 02:50:26 INFO - PROCESS | 9321 | __start_cc_report 02:50:26 INFO - PROCESS | 9321 | _x_x_mozilla_cycle_collect,930 02:50:26 INFO - PROCESS | 9321 | __end_cc_report 02:50:26 INFO - PROCESS | 9321 | __startTimestamp1462960226043__endTimestamp 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - PROCESS | 9321 | ------- Summary: start ------- 02:50:26 INFO - PROCESS | 9321 | Number of tests: 6 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - PROCESS | 9321 | [#0] dojo.html Cycles:165 Average:4688.26 Median:4845.64 stddev:497.61 (10.3%) stddev-sans-first:471.90 02:50:26 INFO - PROCESS | 9321 | Values: 2618.5 2634.2 2677.9 2680.3 2688.2 4598.7 4677.9 4679.6 4720.9 4732.4 4710.0 4740.4 4744.0 4765.4 4781.0 4293.7 4313.2 4382.2 4407.8 4419.1 4407.8 4457.3 4473.9 4489.3 4501.0 4228.0 4261.8 4266.1 4390.1 4411.2 4279.5 4297.9 4298.8 4300.5 4301.2 4282.8 4315.2 4318.4 4359.5 4383.1 4687.4 4692.7 4700.6 4752.3 4764.7 5130.7 5133.1 5136.4 5167.4 5177.0 5026.8 5088.7 5152.2 5158.2 5231.6 4827.3 4838.3 4846.0 4880.2 4894.0 5137.8 5301.7 5335.1 5338.5 5348.4 4876.3 4915.5 4916.0 4957.8 4977.3 5000.1 5004.9 5006.0 5008.2 5042.6 4910.1 4946.2 4950.0 4956.4 4996.2 4879.1 4934.8 4944.8 4948.5 4986.7 4228.5 4233.7 4258.2 4266.2 4271.7 3718.3 3731.6 3763.3 3778.3 3779.5 4257.2 4294.4 4354.2 4360.9 4361.3 5137.9 5142.7 5146.6 5170.2 5213.8 4266.1 4346.8 4359.4 4362.4 4408.6 4560.1 4617.7 4640.6 4651.4 4660.9 4814.4 4843.2 4845.6 4847.3 4895.8 4997.4 5061.6 5144.6 5155.8 5209.6 4771.9 4786.9 4808.6 4809.1 4852.6 5018.5 5029.8 5030.6 5033.8 5080.8 4930.8 5041.1 5062.6 5089.2 5097.3 4924.1 4929.9 4940.8 4944.0 4967.7 4942.3 4947.0 4948.1 4950.4 4983.5 4724.5 4802.0 4818.5 4829.5 4910.0 4940.0 4956.3 4970.2 4984.9 5007.6 4851.5 4853.6 4857.7 4863.3 4921.2 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - PROCESS | 9321 | [#1] ext.html Cycles:180 Average:44801.98 Median:327871.50 stddev:77976.88 (23.8%) stddev-sans-first:78124.91 02:50:26 INFO - PROCESS | 9321 | Values: 574.5 599.4 612.2 615.6 630.4 27034.6 41930.6 43069.6 43073.0 43122.0 42228.9 42763.0 42910.0 42921.0 42923.4 7434.3 7897.3 8003.5 9975.7 10245.0 10079.2 10129.2 10164.9 10172.5 10188.5 10210.3 10252.8 10258.2 10259.8 10262.4 7555.7 10001.4 10317.6 10320.2 10598.2 10112.2 10169.6 10177.3 10178.3 10189.5 38994.8 39144.6 39195.0 39256.4 39259.0 3271.7 3291.2 3328.7 3336.9 3402.3 30057.2 30335.0 30458.0 30473.8 30906.5 3086.0 3097.8 3144.8 3163.7 3201.1 175801.0 176397.0 176751.0 177011.0 177466.0 34842.8 56107.7 56324.7 56472.7 56507.4 34228.3 35917.5 36159.6 36167.6 36193.8 11278.6 12677.7 12826.0 12855.2 12866.4 10345.9 10599.5 10634.7 10819.4 10875.1 8363.3 8375.6 8413.0 8440.9 8476.4 3106.3 3118.9 3133.7 3143.3 3180.2 916.3 924.3 937.4 1077.8 1086.5 29099.4 29795.3 31038.1 31752.4 33295.3 983.2 1023.1 1042.5 1087.9 1088.5 15110.8 15458.8 15497.7 15591.5 15695.8 352107.0 352538.0 354807.0 356223.0 356252.0 50149.0 50310.5 50425.2 50431.0 50598.5 1164.8 1251.1 1289.9 1306.1 1322.9 27073.5 30142.2 30211.0 30238.7 30815.0 44635.6 45114.5 45400.8 45450.3 45626.3 321815.0 326784.0 327394.0 327562.0 328181.0 34696.7 35621.6 40508.0 41324.6 41437.8 42690.0 43220.1 43239.4 43843.0 44069.6 36792.6 37608.2 37625.8 37666.8 38381.6 36858.6 36930.4 37490.6 37603.2 37633.8 36107.5 36706.0 37040.3 37111.8 37197.8 29516.0 29777.6 30189.0 30214.7 30276.8 25304.6 25894.7 25947.0 25957.7 26305.3 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - PROCESS | 9321 | [#2] jquery.html Cycles:180 Average:26028.14 Median:456279.21 stddev:72913.82 (16.0%) stddev-sans-first:73092.91 02:50:26 INFO - PROCESS | 9321 | Values: 371.3 386.8 390.6 391.1 399.5 15845.3 17588.7 17793.7 17826.1 17826.9 16851.7 16866.3 17102.6 17608.3 17638.9 4825.3 4988.5 5221.4 5232.0 5271.6 3669.0 4631.9 5917.2 5929.9 6057.6 5920.1 5959.2 5971.0 6088.7 6095.9 5823.4 6077.5 6079.5 6084.2 6089.8 4674.6 5331.8 5334.7 5336.0 5338.0 12223.4 12290.9 12365.3 12384.3 12429.0 2062.6 2086.9 2200.0 2355.0 2393.9 9122.3 9259.8 9450.0 9544.8 10940.4 1757.6 1757.9 1773.8 1796.8 1831.9 71482.0 74312.6 74995.6 75278.6 76358.6 10434.7 10496.2 10518.6 10836.2 10901.8 14583.9 14665.9 14698.6 14707.8 14713.8 7282.2 7483.8 7497.9 7593.6 7633.0 6983.7 7013.6 7134.3 7137.0 7268.7 4397.1 4454.7 4464.7 4485.5 4598.1 1866.5 1917.6 1923.3 1931.4 1967.7 701.7 796.6 889.6 1002.6 1014.9 16195.6 16986.0 17115.7 17402.8 17413.1 859.3 879.9 887.1 903.7 932.7 9332.2 9478.9 9578.3 9639.4 9812.8 412111.0 414212.0 454074.0 458484.4 466171.0 80386.6 86819.6 86901.6 87633.1 88094.0 925.4 940.6 952.0 963.6 972.4 15532.8 15809.7 15847.6 16052.3 16315.5 34791.3 35667.0 35740.5 36915.0 37214.6 50483.5 51078.5 51883.5 52347.2 52639.7 7202.6 7546.0 7553.5 7732.3 7733.7 10825.0 11400.3 11586.7 11667.9 11721.5 9872.2 10262.9 10293.0 10345.8 10420.7 9789.9 10250.6 10294.9 10296.0 10324.1 9901.7 10104.6 10393.8 10592.7 10706.5 7728.3 7966.1 8001.8 8034.6 8152.3 7888.4 9675.7 10608.9 10663.4 10861.3 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - PROCESS | 9321 | [#3] mootools.html Cycles:180 Average:5206.61 Median:5593.61 stddev:2889.57 (51.7%) stddev-sans-first:2882.86 02:50:26 INFO - PROCESS | 9321 | Values: 1313.4 1517.8 1534.2 1704.7 1903.0 6664.5 7630.4 7880.1 7900.9 8127.6 7862.8 8014.4 8036.2 8042.6 8043.0 1848.5 2156.4 2208.4 2210.9 2240.4 2182.4 2206.2 2206.3 2210.3 2211.4 2076.7 2088.1 2107.2 2107.9 2108.4 1819.2 1871.9 1876.4 2041.0 2043.6 2157.0 2201.1 2203.1 2206.5 2207.3 7719.6 7772.9 7783.3 7791.9 7825.3 4558.4 4686.5 4690.0 4693.1 4695.9 2698.6 2809.9 2811.6 2822.8 2863.8 852.6 858.7 859.0 865.5 871.2 10871.2 10948.4 10988.9 10989.5 11023.8 4036.1 4044.9 4177.2 4180.8 4189.5 9297.0 9321.9 9340.9 9344.0 9381.9 4707.2 4709.5 4713.2 4713.4 4718.1 3792.5 4252.9 4350.2 4358.5 4404.3 3704.0 3760.5 3774.5 3820.3 3874.8 1202.3 1209.5 1214.9 1224.0 1235.4 922.8 932.7 935.7 941.7 968.2 5488.8 5582.1 5653.8 5741.4 5750.6 861.1 862.2 867.5 906.8 917.1 3838.1 3928.6 3945.0 3951.9 4010.4 9042.9 9186.6 9417.9 9418.2 9474.4 9330.8 9354.8 9402.5 9437.1 9451.4 7101.9 7103.1 7399.4 7459.5 7515.2 5414.9 5444.4 5449.9 5588.0 5599.2 8599.8 8755.7 9024.0 9047.4 9196.6 8894.2 9120.3 9169.8 9180.3 9193.0 5902.4 6079.9 6081.1 6427.1 6519.1 7084.8 7406.4 7558.1 7645.5 7831.8 6962.0 7056.9 7098.5 7174.1 7213.0 6724.9 6963.3 7004.4 7028.4 7048.4 6268.7 6537.2 6538.6 6576.4 6643.4 4887.5 4930.1 4939.5 4939.9 4965.0 4937.9 4972.9 4999.1 5007.3 5078.3 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - PROCESS | 9321 | [#4] prototype.html Cycles:180 Average:4126.52 Median:4743.25 stddev:1169.20 (24.6%) stddev-sans-first:1137.00 02:50:26 INFO - PROCESS | 9321 | Values: 318.1 323.4 327.2 330.7 333.4 4788.5 4803.2 4829.2 4831.7 4846.9 4713.8 4740.3 4786.3 4787.8 4789.5 3552.7 3695.9 3710.6 3821.9 3855.0 3720.7 3771.8 3808.4 3809.8 3822.3 3756.2 3769.2 3779.6 3786.2 3799.9 3580.9 3664.7 3758.6 3773.5 3807.5 3363.0 3366.7 3381.7 3386.6 3392.3 4525.9 4526.6 4535.5 4538.5 4558.7 4214.3 4257.8 4287.8 4311.4 4336.0 4969.1 4978.5 4991.5 4999.5 5000.3 3666.8 3701.6 3712.5 3714.6 3717.4 4927.4 5236.4 5238.1 5238.8 5247.9 3668.2 3669.0 3676.6 3698.2 3702.6 3716.4 3733.3 3736.8 3745.3 3763.5 4226.7 4230.2 4231.5 4245.7 4272.6 4751.6 4970.6 4980.8 5059.7 5071.8 1291.3 1298.0 1304.7 1305.8 1309.8 801.6 831.7 867.9 884.5 896.5 4261.3 4279.6 4283.6 4315.0 4319.2 5031.2 5064.8 5089.9 5092.2 5093.2 4050.4 4292.3 4306.7 4319.1 4324.0 2711.3 2730.2 2740.9 2742.5 2745.5 4801.7 4818.9 4822.1 4843.8 4862.9 4969.8 5169.3 5182.2 5242.6 5255.3 4716.9 4746.2 4752.6 4754.1 4788.2 4970.1 4989.6 5029.6 5060.2 5060.4 4679.4 4930.6 4960.8 4961.5 4973.0 4684.6 4754.8 4758.7 4763.8 4772.8 3635.5 3645.1 3653.9 3671.9 3694.2 4918.4 5077.5 5091.2 5097.4 5109.4 4830.8 4846.1 4853.5 4865.5 4868.9 4850.1 4859.4 4865.9 4921.0 4922.1 4510.3 4755.3 4780.3 4805.0 4842.8 4792.6 4867.3 4922.2 4959.3 4974.8 4852.3 4868.3 4909.4 4928.5 4997.0 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - PROCESS | 9321 | [#5] yui.html Cycles:180 Average:12980.06 Median:45058.39 stddev:14700.51 (32.6%) stddev-sans-first:14713.04 02:50:26 INFO - PROCESS | 9321 | Values: 747.0 779.6 793.7 806.4 824.5 11885.3 12489.8 12492.0 12495.3 12501.3 11572.6 11605.6 11623.7 11628.5 11630.9 673.2 827.2 851.5 856.2 856.2 852.6 853.4 855.4 856.4 856.5 908.8 911.1 911.5 911.6 911.6 706.2 887.8 919.5 919.5 923.3 682.1 682.8 683.1 683.6 683.9 11521.7 11531.5 11547.9 11583.4 11593.3 12280.8 12706.7 12717.2 12739.6 13009.0 10393.5 10815.6 10850.9 11203.2 11348.2 4192.5 4209.6 4216.9 4247.3 4331.4 41874.8 42174.2 43609.6 43794.3 44024.3 9327.8 9442.3 9587.7 10212.3 10350.2 17336.1 17441.1 17549.4 17639.8 17650.6 6411.7 6429.4 6486.4 6528.4 6589.3 3396.9 3425.6 3456.5 3504.8 3593.3 2683.7 2779.8 2781.4 2787.7 2790.9 449.0 505.5 515.9 517.4 572.7 587.8 609.5 630.1 630.7 637.1 8425.6 8624.0 8755.5 8787.3 8852.6 547.2 631.0 637.4 642.6 662.8 3887.4 4131.4 4148.1 4155.7 4262.9 51793.0 53823.2 54203.0 54459.0 54561.7 47016.5 48410.0 48822.5 49927.0 50677.2 44958.0 45158.8 45316.3 45880.3 46284.3 7936.9 7970.4 8067.4 8090.3 8149.8 30652.2 30655.8 30779.5 30814.4 31386.2 35101.6 37750.8 38941.0 39018.4 39144.0 9816.2 9983.3 9986.4 10217.2 10288.7 11911.3 11965.2 12049.6 12426.4 12478.6 11234.1 11266.2 11773.6 11781.9 11850.1 11379.5 11532.6 11875.3 11964.2 11974.8 10727.3 11022.9 11238.2 11321.3 11798.6 9307.4 9521.2 9552.5 9692.0 9805.2 9706.0 9732.8 9773.9 9809.0 9849.1 02:50:26 INFO - PROCESS | 9321 | -------- Summary: end -------- 02:50:26 INFO - PROCESS | 9321 | 02:50:26 INFO - TEST-INFO | 9321: exit 0 02:50:26 INFO - TEST-OK | dromaeo_css | took 1119013ms 02:50:26 INFO - TEST-START | kraken 02:50:26 INFO - operating with platform_type : linux_ 02:50:26 INFO - Initialising browser for kraken test... 02:50:26 INFO - TEST-INFO | started process 9502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn81Rfo/profile http://localhost:48400/getInfo.html) 02:50:30 INFO - PROCESS | 9502 | __metrics Screen width/height:1600/1200 02:50:30 INFO - PROCESS | 9502 | colorDepth:24 02:50:30 INFO - PROCESS | 9502 | Browser inner width/height: 1024/697 02:50:30 INFO - PROCESS | 9502 | __metrics 02:50:31 ERROR - PROCESS | 9502 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:50:32 INFO - TEST-INFO | 9502: exit 0 02:50:32 INFO - Browser initialized. 02:50:32 INFO - Running cycle 1/1 for kraken test... 02:50:32 INFO - TEST-INFO | started process 9583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn81Rfo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:44 INFO - PROCESS | 9583 | RSS: Main: 154054656 02:50:44 INFO - PROCESS | 9583 | 02:50:47 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48400/tests/kraken/driver.html?testName=audio-beat-detection) 02:50:48 INFO - PROCESS | 9583 | RSS: Main: 209555456 02:50:48 INFO - PROCESS | 9583 | 02:50:51 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48400/tests/kraken/driver.html?testName=audio-dft) 02:50:51 INFO - PROCESS | 9583 | RSS: Main: 197918720 02:50:51 INFO - PROCESS | 9583 | 02:50:55 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48400/tests/kraken/driver.html?testName=audio-fft) 02:50:55 INFO - PROCESS | 9583 | RSS: Main: 266530816 02:50:55 INFO - PROCESS | 9583 | 02:50:58 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48400/tests/kraken/driver.html?testName=audio-oscillator) 02:50:58 INFO - PROCESS | 9583 | RSS: Main: 175734784 02:50:58 INFO - PROCESS | 9583 | 02:51:01 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:51:01 INFO - PROCESS | 9583 | RSS: Main: 179142656 02:51:01 INFO - PROCESS | 9583 | 02:51:04 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48400/tests/kraken/driver.html?testName=imaging-darkroom) 02:51:05 INFO - PROCESS | 9583 | RSS: Main: 216043520 02:51:05 INFO - PROCESS | 9583 | 02:51:09 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48400/tests/kraken/driver.html?testName=imaging-desaturate) 02:51:09 INFO - PROCESS | 9583 | RSS: Main: 215232512 02:51:09 INFO - PROCESS | 9583 | 02:51:12 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48400/tests/kraken/driver.html?testName=json-parse-financial) 02:51:13 INFO - PROCESS | 9583 | RSS: Main: 215822336 02:51:13 INFO - PROCESS | 9583 | 02:51:15 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:51:16 INFO - PROCESS | 9583 | RSS: Main: 210096128 02:51:16 INFO - PROCESS | 9583 | 02:51:17 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48400/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:51:18 INFO - PROCESS | 9583 | RSS: Main: 210186240 02:51:18 INFO - PROCESS | 9583 | 02:51:20 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:51:21 INFO - PROCESS | 9583 | RSS: Main: 214376448 02:51:21 INFO - PROCESS | 9583 | 02:51:24 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:51:25 INFO - PROCESS | 9583 | RSS: Main: 217997312 02:51:25 INFO - PROCESS | 9583 | 02:51:28 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:51:28 INFO - PROCESS | 9583 | RSS: Main: 218001408 02:51:28 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | Cycle 1(1): loaded http://localhost:48400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48400/tests/kraken/driver.html?testName=ai-astar) 02:51:30 INFO - PROCESS | 9583 | RSS: Main: 264187904 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | __start_tp_report 02:51:30 INFO - PROCESS | 9583 | _x_x_mozilla_page_load 02:51:30 INFO - PROCESS | 9583 | _x_x_mozilla_page_load_details 02:51:30 INFO - PROCESS | 9583 | |i|pagename|runs| 02:51:30 INFO - PROCESS | 9583 | |0;ai-astar;114;108;113;114;114;113;113;113;113;114 02:51:30 INFO - PROCESS | 9583 | |1;audio-beat-detection;167;132;169;215;130;158;156;134;185;132 02:51:30 INFO - PROCESS | 9583 | |2;audio-dft;162;161;162;161;162;162;161;160;161;161 02:51:30 INFO - PROCESS | 9583 | |3;audio-fft;77;77;77;153;75;77;76;77;128;75 02:51:30 INFO - PROCESS | 9583 | |4;audio-oscillator;94;93;153;93;93;93;120;93;95;123 02:51:30 INFO - PROCESS | 9583 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;117;117;117 02:51:30 INFO - PROCESS | 9583 | |6;imaging-darkroom;146;145;145;147;146;145;145;147;145;145 02:51:30 INFO - PROCESS | 9583 | |7;imaging-desaturate;94;95;95;95;94;95;94;95;94;95 02:51:30 INFO - PROCESS | 9583 | |8;json-parse-financial;67;68;67;69;68;70;69;68;67;69 02:51:30 INFO - PROCESS | 9583 | |9;json-stringify-tinderbox;64;63;64;64;64;63;65;64;63;64 02:51:30 INFO - PROCESS | 9583 | |10;stanford-crypto-aes;89;81;82;81;82;84;83;83;165;83 02:51:30 INFO - PROCESS | 9583 | |11;stanford-crypto-ccm;142;134;131;135;129;133;128;132;152;139 02:51:30 INFO - PROCESS | 9583 | |12;stanford-crypto-pbkdf2;178;178;188;181;175;175;173;177;173;173 02:51:30 INFO - PROCESS | 9583 | |13;stanford-crypto-sha256-iterative;69;70;69;72;68;68;69;68;67;68 02:51:30 INFO - PROCESS | 9583 | __end_tp_report 02:51:30 INFO - PROCESS | 9583 | __start_cc_report 02:51:30 INFO - PROCESS | 9583 | _x_x_mozilla_cycle_collect,2111 02:51:30 INFO - PROCESS | 9583 | __end_cc_report 02:51:30 INFO - PROCESS | 9583 | __startTimestamp1462960290756__endTimestamp 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | ------- Summary: start ------- 02:51:30 INFO - PROCESS | 9583 | Number of tests: 14 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.50 stddev:1.79 (1.6%) stddev-sans-first:1.86 02:51:30 INFO - PROCESS | 9583 | Values: 114.0 108.0 113.0 114.0 114.0 113.0 113.0 113.0 113.0 114.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#1] audio-beat-detection Cycles:10 Average:157.80 Median:162.50 stddev:27.68 (17.0%) stddev-sans-first:29.16 02:51:30 INFO - PROCESS | 9583 | Values: 167.0 132.0 169.0 215.0 130.0 158.0 156.0 134.0 185.0 132.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 02:51:30 INFO - PROCESS | 9583 | Values: 162.0 161.0 162.0 161.0 162.0 162.0 161.0 160.0 161.0 161.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#3] audio-fft Cycles:10 Average:89.20 Median:77.00 stddev:27.68 (36.0%) stddev-sans-first:29.01 02:51:30 INFO - PROCESS | 9583 | Values: 77.0 77.0 77.0 153.0 75.0 77.0 76.0 77.0 128.0 75.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:93.00 stddev:20.53 (22.1%) stddev-sans-first:21.39 02:51:30 INFO - PROCESS | 9583 | Values: 94.0 93.0 153.0 93.0 93.0 93.0 120.0 93.0 95.0 123.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 02:51:30 INFO - PROCESS | 9583 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 02:51:30 INFO - PROCESS | 9583 | Values: 146.0 145.0 145.0 147.0 146.0 145.0 145.0 147.0 145.0 145.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:51:30 INFO - PROCESS | 9583 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:68.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 02:51:30 INFO - PROCESS | 9583 | Values: 67.0 68.0 67.0 69.0 68.0 70.0 69.0 68.0 67.0 69.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 02:51:30 INFO - PROCESS | 9583 | Values: 64.0 63.0 64.0 64.0 64.0 63.0 65.0 64.0 63.0 64.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:83.00 stddev:26.00 (31.3%) stddev-sans-first:27.56 02:51:30 INFO - PROCESS | 9583 | Values: 89.0 81.0 82.0 81.0 82.0 84.0 83.0 83.0 165.0 83.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:134.50 stddev:7.20 (5.4%) stddev-sans-first:7.24 02:51:30 INFO - PROCESS | 9583 | Values: 142.0 134.0 131.0 135.0 129.0 133.0 128.0 132.0 152.0 139.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:177.50 stddev:4.65 (2.6%) stddev-sans-first:4.92 02:51:30 INFO - PROCESS | 9583 | Values: 178.0 178.0 188.0 181.0 175.0 175.0 173.0 177.0 173.0 173.0 02:51:30 INFO - PROCESS | 9583 | 02:51:30 INFO - PROCESS | 9583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 02:51:30 INFO - PROCESS | 9583 | Values: 69.0 70.0 69.0 72.0 68.0 68.0 69.0 68.0 67.0 68.0 02:51:30 INFO - PROCESS | 9583 | -------- Summary: end -------- 02:51:30 INFO - PROCESS | 9583 | 02:51:31 INFO - TEST-INFO | 9583: exit 0 02:51:31 INFO - TEST-OK | kraken | took 64989ms 02:51:31 INFO - SUITE-END | took 1184s 02:51:31 INFO - Completed test suite (00:19:44) 02:51:31 INFO - javascript benchmark 02:51:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.5155746186956, 2634.196570046135, 2677.8661066946647, 2680.2897232233463, 2688.1801050679546, 4598.724076555405, 4677.883052923678, 4679.602233810122, 4720.8583742487735, 4732.36113124728, 4709.987352719165, 4740.431148262213, 4743.976280118603, 4765.380500534934, 4780.9760951195285, 4293.7209081409765, 4313.2020576193345, 4382.189294980439, 4407.80164892579, 4419.11617676466, 4407.82368705253, 4457.264551349023, 4473.88815279619, 4489.259272220096, 4500.97749511252, 4228.0, 4261.808218630169, 4266.146770645883, 4390.056137930328, 4411.228035093862, 4279.486461624594, 4297.871063868089, 4298.849540266107, 4300.548442413564, 4301.247281725686, 4282.828686852522, 4315.244832154361, 4318.352247162919, 4359.520452750195, 4383.145286669101, 4687.39063921688, 4692.718436893797, 4700.647451441156, 4752.310914917352, 4764.714117152947, 5130.666506677054, 5133.050385678662, 5136.383633963948, 5167.4057483389515, 5177.042247184283, 5026.824061157842, 5088.745562721849, 5152.227165925104, 5158.226266060084, 5231.607629427808, 4827.300041494034, 4838.322634831126, 4845.95154048455, 4880.219164933594, 4894.045661096052, 5137.794488220429, 5301.655392399482, 5335.093034184198, 5338.519533241949, 5348.3849357323625, 4876.268559716071, 4915.508449155056, 4915.992221594564, 4957.801687932442, 4977.32806071183, 5000.1249781288125, 5004.899902002013, 5006.048850718352, 5008.198688209869, 5042.621803364762, 4910.091633047826, 4946.208606622923, 4949.975250123726, 4956.3804524434445, 4996.150654388763, 4879.1461494238365, 4934.753262336941, 4944.802207911715, 4948.529889660476, 4986.650934434628, 4228.471441069866, 4233.661307095425, 4258.190943720683, 4266.189424009428, 4271.700980931305, 3718.3492888744363, 3731.645493678096, 3763.303788799081, 3778.282126396031, 3779.4708740776314, 4257.23369793434, 4294.441722576045, 4354.172707185625, 4360.912781744348, 4361.280388735887, 5137.8715532112, 5142.6914385137015, 5146.614003949644, 5170.17277235648, 5213.817516386908, 4266.1254442839145, 4346.782660866944, 4359.367891655692, 4362.367456718822, 4408.559144085566, 4560.065186636732, 4617.653675974316, 4640.559146881041, 4651.4418269807165, 4660.883477913079, 4814.398200224972, 4843.2250839865455, 4845.63657725665, 4847.297141914332, 4895.779689913891, 4997.400311962588, 5061.595072394126, 5144.562712169508, 5155.845324640267, 5209.609279303992, 4771.928421073756, 4786.904261914672, 4808.591269742111, 4809.110314591811, 4852.636052296162, 5018.4981501849525, 5029.7988080477835, 5030.647854650139, 5033.773480193327, 5080.796768129233, 4930.827421040246, 5041.092603331289, 5062.645614806928, 5089.236614507853, 5097.337346144977, 4924.064427758714, 4929.9014019720125, 4940.75296235194, 4944.035912996931, 4967.7019378837385, 4942.308076869169, 4947.01059788051, 4948.084604348207, 4950.430700469348, 4983.476734942778, 4724.503927087606, 4802.0, 4818.494058123846, 4829.492903245108, 4910.042541704476, 4940.0, 4956.281339205867, 4970.229614409773, 4984.8753781155765, 5007.574356179765, 4851.51484851512, 4853.563179313879, 4857.732824694675, 4863.270509423614, 4921.237208232729], "value": 4656.282701260993, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4657468554245, 599.3766482857828, 612.161338965617, 615.6183166436809, 630.4074170279933, 27034.5944810828, 41930.58069419305, 43069.56930430691, 43073.0, 43122.0, 42228.94427639311, 42763.0, 42910.0, 42921.0, 42923.35614965778, 7434.256574342577, 7897.289243968042, 8003.4797738146835, 9975.650852220173, 10245.0, 10079.193664506858, 10129.189664826834, 10164.898351016505, 10172.491375431237, 10188.490575471234, 10210.336328138685, 10252.846207306897, 10258.23063270254, 10259.794804103913, 10262.435566043865, 7555.659995300197, 10001.399916005026, 10317.638882639147, 10320.225983051227, 10598.152147828156, 10112.191024718006, 10169.644062457852, 10177.338472999232, 10178.338408003456, 10189.490525473697, 38994.80502597469, 39144.608553914666, 39195.0, 39256.41115383243, 39259.0, 3271.7219036381935, 3291.1607540077125, 3328.700416962485, 3336.9332613347597, 3402.319536092791, 30057.248568785737, 30335.0, 30458.0, 30473.847630761928, 30906.53640195399, 3086.0486951856356, 3097.845107744626, 3144.827034513101, 3163.6678148794276, 3201.119692084672, 175801.0, 176397.0, 176751.0, 177011.0, 177466.0, 34842.82578587091, 56107.71946140325, 56324.71837640786, 56472.71763641156, 56507.43492565104, 34228.315433691685, 35917.46123808145, 36159.638403616154, 36167.638323616426, 36193.81903090468, 11278.605248816251, 12677.746445071047, 12826.038047146501, 12855.164414313227, 12866.421011054525, 10345.896541034645, 10599.470026498644, 10634.734131646615, 10819.404932728617, 10875.075618572351, 8363.330933525303, 8375.581220938928, 8412.957935210407, 8440.873386899202, 8476.36427267945, 3106.254498920288, 3118.922026949299, 3133.686631336848, 3143.2927591291777, 3180.173154979722, 916.2532535983286, 924.2652091587204, 937.3672770879629, 1077.8059949209219, 1086.5056399338282, 29099.41801163965, 29795.255118621775, 31038.05138511838, 31752.364952700817, 33295.334093318, 983.1937810995058, 1023.125227930124, 1042.4527123260198, 1087.923845330835, 1088.472091035847, 15110.773338399713, 15458.768118478232, 15497.690046199239, 15591.454299099478, 15695.764563531557, 352107.0, 352538.0, 354807.0, 356223.0, 356252.0, 50149.0, 50310.49689503131, 50425.24362134571, 50430.96552275809, 50598.49401506012, 1164.8310994905692, 1251.0929576057285, 1289.9032572557096, 1306.0726883912528, 1322.9338533073114, 27073.45853082888, 30142.246443839078, 30211.0, 30238.69761302359, 30815.0, 44635.553644463136, 45114.548854512344, 45400.77299613481, 45450.31824522701, 45626.31560526661, 321815.0, 326784.0, 327394.0, 327562.0, 328181.0, 34696.653033469345, 35621.643783561834, 40508.0, 41324.58675413328, 41437.79281103575, 42690.0, 43220.13559728725, 43239.35140972951, 43843.0, 44069.559304406546, 36792.63207367892, 37608.247835042595, 37625.81187094047, 37666.811665941495, 38381.6161838378, 36858.63141368659, 36930.44604330883, 37490.625093749804, 37603.24793504169, 37633.81183094067, 36107.45838812472, 36706.0, 37040.259194815415, 37111.81444092762, 37197.814010929775, 29516.0, 29777.553336699533, 30189.0, 30214.69785302207, 30276.84861575678, 25304.620430693187, 25894.741052589234, 25947.0, 25957.74042259629, 26305.342366440993], "value": 17384.209406836148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.305658418757, 386.76407391491205, 390.60743952327914, 391.13949311514665, 399.4507552115839, 15845.286962086704, 17588.736168957443, 17793.7330940036, 17826.108694565268, 17826.910865445672, 16851.74722379165, 16866.325346986105, 17102.572435689115, 17608.295668173258, 17638.91180544099, 4825.348577941977, 4988.5260900214425, 5221.399539053001, 5231.973840130794, 5271.604629652772, 3668.963310366889, 4631.93052104217, 5917.20117784098, 5929.88140237195, 6057.575969682124, 5920.111983202532, 5959.225300710901, 5970.97014514929, 6088.695565221721, 6095.939040609604, 5823.417658234185, 6077.513798896078, 6079.544034197431, 6084.178635884144, 6089.817305480843, 4674.555917187896, 5331.760070796823, 5334.679919204821, 5335.973320133413, 5337.973310133424, 12223.449944752507, 12290.877091229153, 12365.31990740509, 12384.256944583354, 12429.0, 2062.5668609592003, 2086.926957556478, 2200.0, 2354.9638159209894, 2393.916212932539, 9122.315826312986, 9259.814803703888, 9450.0, 9544.761380965461, 10940.3982780947, 1757.613325068483, 1757.9208935597928, 1773.7516747655338, 1796.8203179681927, 1831.8992455414948, 71482.0, 74312.62843685801, 74995.62502187454, 75278.62360688162, 76358.6182069086, 10434.68695939123, 10496.212784041074, 10518.632577764842, 10836.187285953427, 10901.83647245292, 14583.92708036453, 14665.853341466449, 14698.63253418673, 14707.779383309258, 14713.779293310608, 7282.198958114604, 7483.775486735407, 7497.850042999109, 7593.620318984029, 7632.961835190788, 6983.720651173998, 7013.6142512161305, 7134.286571342825, 7137.0, 7268.709251629875, 4397.076613911115, 4454.732716037048, 4464.709793863389, 4485.529019452911, 4598.103369842848, 1866.496046067554, 1917.6164767046369, 1923.2883832981886, 1931.4012656076661, 1967.704844273342, 701.6702149989496, 796.5539297993026, 889.5507768576956, 1002.5538635307219, 1014.8883622801486, 16195.595110122342, 16986.0, 17115.657686846193, 17402.82597174012, 17413.12934353277, 859.3125499600295, 879.8548239540404, 887.0951629338039, 903.701778413122, 932.6922115701938, 9332.16010559053, 9478.905210947802, 9578.329516933887, 9639.421634701941, 9812.754681133028, 412111.0, 414212.0, 454074.0, 458484.4151558508, 466171.0, 80386.59806701046, 86819.56590217008, 86901.56549217213, 87633.12366876377, 88094.0, 925.3984909808544, 940.619049285027, 951.9762005949768, 963.5760265483165, 972.4359871274644, 15532.844671553139, 15809.68380632404, 15847.603809904844, 16052.3145069766, 16315.510534683504, 34791.304173916884, 35667.0, 35740.4638930411, 36915.0, 37214.62785372112, 50483.495165047876, 51078.48921510737, 51883.48116518786, 52347.21479177739, 52639.73680131575, 7202.639868006683, 7545.962270188614, 7553.509021913558, 7732.342750866239, 7733.690652373842, 10825.0, 11400.258983166068, 11586.652400428, 11667.883321166679, 11721.472533735832, 9872.160866326156, 10262.914783650906, 10293.0, 10345.84481232767, 10420.739481512719, 9789.9021009789, 10250.58997640116, 10294.897051029393, 10296.0, 10324.122449591869, 9901.702948911545, 10104.595816167564, 10393.844092338772, 10592.735181620521, 10706.518206680874, 7728.26581474759, 7966.1237263902085, 8001.799955001172, 8034.558099304594, 8152.307053900485, 7888.408369372435, 9675.70972870815, 10608.946955265174, 10663.360198388122, 10861.348319100563], "value": 8347.664911192436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.3892739875955, 1517.8330383657797, 1534.2175490499844, 1704.727243641017, 1902.952426189346, 6664.533482656216, 7630.351420129289, 7880.133185349607, 7900.8814867776955, 8127.5529845858455, 7862.803429914241, 8014.358851291897, 8036.2365575270405, 8042.638081286342, 8043.0, 1848.4916647921862, 2156.406988078283, 2208.4147700859285, 2210.8784016879067, 2240.361496973363, 2182.356204919545, 2206.205765924266, 2206.30501392061, 2210.2706106984656, 2211.436083798629, 2076.6884967254955, 2088.1438610169835, 2107.1887323380456, 2107.862988905724, 2108.388567315477, 1819.2177363733656, 1871.9251229950785, 1876.4464482977555, 2040.9897950510226, 2043.632146213681, 2156.9892150539304, 2201.119552179141, 2203.129763743312, 2206.4594174427207, 2207.293666026872, 7719.575423351714, 7772.922270777276, 7783.299503044753, 7791.883121753178, 7825.295723384866, 4558.430196225472, 4686.53134686532, 4689.953100468986, 4693.061387722435, 4695.859124226278, 2698.5547384681504, 2809.9016534421403, 2811.550151975674, 2822.7600653944232, 2863.7852161088003, 852.5609311204735, 858.6908712863365, 858.9828203435959, 865.5499140446996, 871.2159056848824, 10871.184661150366, 10948.3978381189, 10988.890111098946, 10989.505472253768, 11023.779524409467, 4036.0717035082093, 4044.8988775280263, 4177.185448837508, 4180.770057646859, 4189.539150693421, 9297.0, 9321.860172097424, 9340.906590934139, 9344.0, 9381.906180938104, 4707.223308154116, 4709.529047095263, 4713.175194340976, 4713.434387873477, 4718.103560323528, 3792.50697409335, 4252.87241382759, 4350.238708226111, 4358.5205627380965, 4404.295312749945, 3703.9814800925824, 3760.511133552621, 3774.47157397959, 3820.2932457495453, 3874.8062596870045, 1202.290648517379, 1209.498058305811, 1214.9028077753758, 1224.0268986156027, 1235.4008305971597, 922.7508572685338, 932.7248461703814, 935.6771913689767, 941.651588912107, 968.1722127580957, 5488.835334939959, 5582.078956972054, 5653.80211692597, 5741.368449470555, 5750.597458177887, 861.1087524412203, 862.2326129744532, 867.5228624256633, 906.7642412972675, 917.092078841955, 3838.1172330364175, 3928.626780455852, 3945.0, 3951.9012024699614, 4010.438538604598, 9042.909570904338, 9186.63253469867, 9417.858732119024, 9418.15236628693, 9474.38416502925, 9330.766730831783, 9354.766130846783, 9402.482863442576, 9437.103475169848, 9451.38565993222, 7101.928980710127, 7103.147622285359, 7399.408047356199, 7459.477836551498, 7515.21090285523, 5414.864628384322, 5444.428335024765, 5449.918251226156, 5588.0, 5599.216109744721, 8599.785005374915, 8755.737327880173, 9023.954880225558, 9047.411918225294, 9196.632134714537, 8894.243989260985, 9120.315976301936, 9169.816603668023, 9180.311476639145, 9193.034731353111, 5902.350741418526, 6079.908801368071, 6081.1486391906055, 6427.068075129174, 6519.08732777421, 7084.822879428056, 7406.444516661164, 7558.13081495635, 7645.464817462725, 7831.804204894923, 6962.0, 7056.894146587702, 7098.503104782822, 7174.139103307636, 7213.0, 6724.8991265132045, 6963.303669632996, 7004.3696067354185, 7028.437724981887, 7048.436125109876, 6268.717907694074, 6537.215534135744, 6538.574992625464, 6576.408123268929, 6643.435307998874, 4887.535684110004, 4930.112579735682, 4939.53074457926, 4939.937913348647, 4964.975175124101, 4937.851864444073, 4972.8756781080765, 4999.082327614072, 5007.273945277987, 5078.263651770399], "value": 4198.592808272603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.06330357098346, 323.4130053952077, 327.16409573539613, 330.7288023820468, 333.43316362184294, 4788.545088216618, 4803.183458812006, 4829.179039563274, 4831.68594041387, 4846.878828029301, 4713.78787954542, 4740.26525888487, 4786.348709695149, 4787.8324258650955, 4789.544993225647, 3552.7157827373876, 3695.9445608315896, 3710.610385909481, 3821.9489640348847, 3855.0, 3720.665140137387, 3771.8491260349692, 3808.409696497047, 3809.752366096209, 3822.3310920588924, 3756.1736417988136, 3769.208466222097, 3779.622037796212, 3786.2238241160494, 3799.9430008549757, 3580.92838143237, 3664.725145614076, 3758.624137586247, 3773.490578771858, 3807.5430948286107, 3362.9742928406827, 3366.663333666638, 3381.712554432876, 3386.5766779152605, 3392.3215356928713, 4525.909481810345, 4526.569975852289, 4535.523770004135, 4538.478075021382, 4558.746344755185, 4214.325707886754, 4257.808398622038, 4287.799416163448, 4311.396404503372, 4336.046069864625, 4969.055879382941, 4978.477259887696, 4991.4758950310425, 4999.500049994971, 5000.274960130797, 3666.834992425347, 3701.648343407372, 3712.535933008374, 3714.5542534895717, 3717.368047431943, 4927.36386033474, 5236.423993360727, 5238.05714971305, 5238.79044838206, 5247.947520524822, 3668.211334563082, 3668.954348010804, 3676.566139205712, 3698.1679122197293, 3702.61122582125, 3716.3682174030478, 3733.290674771785, 3736.813159342022, 3745.3071181831447, 3763.5483741951143, 4226.746395216297, 4230.196262710076, 4231.513375961804, 4245.724027938174, 4272.551382104896, 4751.64362672801, 4970.552650261421, 4980.779708971325, 5059.696418214919, 5071.822486212965, 1291.309149604957, 1297.9935100324626, 1304.6868751499571, 1305.778017736987, 1309.8100775387516, 801.6112185589984, 831.6631764135535, 867.9001914779755, 884.5046773806689, 896.462122726359, 4261.31818908973, 4279.636230920407, 4283.635890949242, 4314.956850431456, 4319.222539942778, 5031.195008798648, 5064.797408103708, 5089.949100509021, 5092.159793634083, 5093.159628661304, 4050.3924411338535, 4292.291771857671, 4306.698531102793, 4319.136172765459, 4323.978380108079, 2711.30861630283, 2730.1536523677723, 2740.9177724668293, 2742.4515096980685, 2745.546984747494, 4801.68789028719, 4818.8795280118275, 4822.107910036654, 4843.806247750121, 4862.854114376574, 4969.776360063805, 5169.302144210558, 5182.196759502283, 5242.554382877498, 5255.290535777621, 4716.853831506724, 4746.240601503743, 4752.643551733634, 4754.120487709715, 4788.233882578771, 4970.080535100873, 4989.575886049726, 5029.572486338702, 5060.165072762953, 5060.418051924076, 4679.438467383936, 4930.556249937379, 4960.751962401793, 4961.5286547777905, 4973.0, 4684.6486513510945, 4754.762261886823, 4758.691359875923, 4763.7618119094595, 4772.809087636456, 3635.4731012974084, 3645.1433913029887, 3653.853845846136, 3671.8984304709015, 3694.224212915318, 4918.43438004634, 5077.466865979019, 5091.1854103343285, 5097.439281678938, 5109.416081014897, 4830.830920917751, 4846.103470857903, 4853.538913803183, 4865.513448655106, 4868.926966095441, 4850.126977144007, 4859.392575928009, 4865.927011094907, 4920.950790492049, 4922.138625740409, 4510.2783554631105, 4755.310479980452, 4780.330753694555, 4805.0, 4842.7578621068105, 4792.616590672668, 4867.318575399518, 4922.237053256751, 4959.305697202467, 4974.7512624369365, 4852.320675105418, 4868.3427737255015, 4909.410870695397, 4928.507149285187, 4997.0], "value": 3764.5834983187483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.9738559150429, 779.5868189859373, 793.662693355324, 806.3670019035052, 824.4805772363407, 11885.34630595318, 12489.750204995895, 12492.0, 12495.250284982896, 12501.312427816467, 11572.594959176431, 11605.593804216855, 11623.709407264823, 11628.476718547665, 11630.883691163086, 673.2392396591869, 827.1521690267464, 851.4720873058682, 856.1652388920784, 856.2465030772943, 852.6163226548047, 853.3557164340945, 855.422589751918, 856.374846362156, 856.4604299291437, 908.8046070094928, 911.08436021798, 911.5123408976199, 911.5624500239888, 911.6490151291767, 706.1984647425184, 887.7603047177258, 919.5172534419416, 919.5310391700215, 923.3259720404076, 682.1405029662611, 682.7507959594761, 683.0914883205324, 683.6376720338229, 683.8871586188272, 11521.654350369503, 11531.538738450452, 11547.884521154765, 11583.420828958602, 11593.304401735923, 12280.815787763191, 12706.74586508274, 12717.23696578199, 12739.61781146567, 13009.0, 10393.53229104692, 10815.621453249098, 10850.891491085067, 11203.21577489576, 11348.205625606128, 4192.4759405074365, 4209.6421804146685, 4216.936745948813, 4247.321184396999, 4331.415258940035, 41874.79062604668, 42174.156516869494, 43609.56390436119, 43794.343084853754, 44024.339634905504, 9327.813443731087, 9442.291828112782, 9587.712368628952, 10212.336198147097, 10350.223733219887, 17336.133193340283, 17441.12794360277, 17549.385771498193, 17639.82360176382, 17650.646987060445, 6411.743530258831, 6429.3570642936265, 6486.44865186455, 6528.412442880163, 6589.275179730226, 3396.864125434955, 3425.5718035245595, 3456.4642480415578, 3504.7546671732734, 3593.2993066352333, 2683.7182095880044, 2779.7915156363356, 2781.374190807093, 2787.693353731088, 2790.8883644654393, 448.9506154323022, 505.45410956167984, 515.9484051594885, 517.3920643244173, 572.705056895699, 587.8295294364672, 609.5093449772976, 630.0643544336656, 630.6846576711645, 637.1334984421184, 8425.620847061897, 8623.956880215559, 8755.474671519729, 8787.340949428819, 8852.601632926406, 547.2448021729987, 630.9936900630935, 637.4135795068548, 642.5887432043496, 662.8309781005813, 3887.3974533947285, 4131.35963925592, 4148.108156746314, 4155.723163225859, 4262.87211383659, 51793.0, 53823.19265211025, 54203.0, 54459.0, 54561.72719136379, 47016.5298347019, 48410.0, 48822.511774881794, 49927.0014599706, 50677.23984140241, 44958.0, 45158.77420612942, 45316.320255196195, 45880.3117953231, 46284.305735414, 7936.920630793849, 7970.4022198336515, 8067.354611631173, 8090.271875531231, 8149.840292322658, 30652.233694157825, 30655.846720766254, 30779.538306924966, 30814.383712326075, 31386.21534461657, 35101.64898351086, 37750.811245943594, 38941.0, 39018.41472377974, 39144.0, 9816.165625921876, 9983.301168918397, 9986.35088719231, 10217.23370747182, 10288.742781430525, 11911.344876031555, 11965.222260553037, 12049.578264761041, 12426.378681066091, 12478.625641230414, 11234.101271898391, 11266.155038371991, 11773.587924422603, 11781.941090294493, 11850.051995840484, 11379.54481820718, 11532.59635912739, 11875.287482751062, 11964.162508624313, 11974.760504790029, 10727.302725322828, 11022.944885275523, 11238.157138214503, 11321.264117832314, 11798.646040618794, 9307.395019323721, 9521.19069879068, 9552.522373881138, 9692.0, 9805.166560842408, 9706.0, 9732.75668108303, 9773.853392199266, 9809.0, 9849.113579777855], "value": 6101.719968045991, "unit": "score"}], "name": "dromaeo_css", "value": 6343.76309571158, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 132.0, 169.0, 215.0, 130.0, 158.0, 156.0, 134.0, 185.0, 132.0], "value": 157.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 153.0, 75.0, 77.0, 76.0, 77.0, 128.0, 75.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 153.0, 93.0, 93.0, 93.0, 120.0, 93.0, 95.0, 123.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 69.0, 68.0, 70.0, 69.0, 68.0, 67.0, 69.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 82.0, 81.0, 82.0, 84.0, 83.0, 83.0, 165.0, 83.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 131.0, 135.0, 129.0, 133.0, 128.0, 132.0, 152.0, 139.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 188.0, 181.0, 175.0, 175.0, 173.0, 177.0, 173.0, 173.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 72.0, 68.0, 68.0, 69.0, 68.0, 67.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1588.1, "alertThreshold": 2.0}]} 02:51:32 INFO - Return code: 0 02:51:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:51:32 ERROR - # TBPL SUCCESS # 02:51:32 INFO - Running post-action listener: _resource_record_post_action 02:51:32 INFO - ##### 02:51:32 INFO - ##### Finished run-tests step (success) 02:51:32 INFO - ##### 02:51:32 INFO - Running post-run listener: _resource_record_post_run 02:51:33 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532045824; Read time: 12; Write time: 597892 02:51:33 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241373184; Read time: 0; Write time: 357440 02:51:33 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290672640; Read time: 12; Write time: 240452 02:51:33 INFO - Running post-run listener: _upload_blobber_files 02:51:33 INFO - Blob upload gear active. 02:51:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:51:33 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 02:51:33 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'] 02:51:33 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 02:51:33 INFO - (blobuploader) - INFO - Open directory for files ... 02:51:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:51:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:51:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:34 INFO - (blobuploader) - INFO - Done attempting. 02:51:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:51:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:51:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:35 INFO - (blobuploader) - INFO - Done attempting. 02:51:35 INFO - (blobuploader) - INFO - Iteration through files over. 02:51:35 INFO - Return code: 0 02:51:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:51:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:51:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7feb92c5e10548ae0e3784ae7e1acbf3dfca8270dc5db1468622ce7b13cce30ca1f2fed9692109faba09c79fb955cb3687a64d547ec6c5fc72d900af9f728b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52ef4ab9f60873d96f9bc5a5c0e49ac0982af672a1424e71a4dd3606c02aa9406e20aded280682f2e9d4288b3c3843342c9ba4b57f601923a91bb15b1c9179a4"} 02:51:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:51:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:51:35 INFO - Contents: 02:51:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7feb92c5e10548ae0e3784ae7e1acbf3dfca8270dc5db1468622ce7b13cce30ca1f2fed9692109faba09c79fb955cb3687a64d547ec6c5fc72d900af9f728b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52ef4ab9f60873d96f9bc5a5c0e49ac0982af672a1424e71a4dd3606c02aa9406e20aded280682f2e9d4288b3c3843342c9ba4b57f601923a91bb15b1c9179a4"} 02:51:35 INFO - Running post-run listener: copy_logs_to_upload_dir 02:51:35 INFO - Copying logs to upload dir... 02:51:35 INFO - mkdir: /builds/slave/test/build/upload/logs 02:51:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.398628 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-11 02:51:33.730692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 02:51:33.733906) ========= 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=232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7feb92c5e10548ae0e3784ae7e1acbf3dfca8270dc5db1468622ce7b13cce30ca1f2fed9692109faba09c79fb955cb3687a64d547ec6c5fc72d900af9f728b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52ef4ab9f60873d96f9bc5a5c0e49ac0982af672a1424e71a4dd3606c02aa9406e20aded280682f2e9d4288b3c3843342c9ba4b57f601923a91bb15b1c9179a4"} build_url:https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/AZMlEAaHTCKgtKuiPrZx7g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7feb92c5e10548ae0e3784ae7e1acbf3dfca8270dc5db1468622ce7b13cce30ca1f2fed9692109faba09c79fb955cb3687a64d547ec6c5fc72d900af9f728b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52ef4ab9f60873d96f9bc5a5c0e49ac0982af672a1424e71a4dd3606c02aa9406e20aded280682f2e9d4288b3c3843342c9ba4b57f601923a91bb15b1c9179a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 02:51:33.758283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:51:33.758584) ========= 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=232498196343f89f466a4a9a000001c8-1462959031.673148-1881464787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 02:51:33.844405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 02:51:33.844754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 02:51:33.845056) ========= ========= Total master_lag: 0.19 =========