builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1460905381.98 results: success (0) buildid: 20160417053014 builduid: 4f6e1b8e0eeb4032bf98c50907d33de4 revision: f8c0dd78206cac5a132b164ebacfa8ffbac9713c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:01.976924) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:01.977532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:01.977845) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:01.995268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:01.995683) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-17 08:03:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-04-17 08:03:02 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:02.130930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:02.131284) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015653 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:02.199463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:02.199826) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8c0dd78206cac5a132b164ebacfa8ffbac9713c --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 f8c0dd78206cac5a132b164ebacfa8ffbac9713c --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=934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-17 08:03:02,399 truncating revision to first 12 chars 2016-04-17 08:03:02,399 Setting DEBUG logging. 2016-04-17 08:03:02,399 attempt 1/10 2016-04-17 08:03:02,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8c0dd78206c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-17 08:03:03,057 unpacking tar archive at: fx-team-f8c0dd78206c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:03.163848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:03.164171) ========= script_repo_revision: f8c0dd78206cac5a132b164ebacfa8ffbac9713c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:03.164582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:03.164854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 08:03:03.173597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-17 08:03:03.173906) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:03:03 INFO - MultiFileLogger online at 20160417 08:03:03 in /builds/slave/test 08:03:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:03:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:03 INFO - {'append_to_log': False, 08:03:03 INFO - 'base_work_dir': '/builds/slave/test', 08:03:03 INFO - 'blob_upload_branch': 'Fx-Team', 08:03:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:03 INFO - 'branch': 'Fx-Team', 08:03:03 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:03 INFO - 'config_files': ('talos/linux_config.py',), 08:03:03 INFO - 'default_actions': ('clobber', 08:03:03 INFO - 'read-buildbot-config', 08:03:03 INFO - 'download-and-extract', 08:03:03 INFO - 'populate-webroot', 08:03:03 INFO - 'create-virtualenv', 08:03:03 INFO - 'install', 08:03:03 INFO - 'run-tests'), 08:03:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:03 INFO - 'download_minidump_stackwalk': True, 08:03:03 INFO - 'download_symbols': 'ondemand', 08:03:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:03 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:03 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:03 INFO - 'installer_path': 'installer.exe', 08:03:03 INFO - 'log_level': 'info', 08:03:03 INFO - 'log_name': 'talos', 08:03:03 INFO - 'log_to_console': True, 08:03:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:03:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:03:03 INFO - 'opt_config_files': (), 08:03:03 INFO - 'pip_index': False, 08:03:03 INFO - 'sps_profile': False, 08:03:03 INFO - 'sps_profile_interval': 0, 08:03:03 INFO - 'suite': 'dromaeojs-e10s', 08:03:03 INFO - 'system_bits': '32', 08:03:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:03 INFO - 'title': 'talos-linux64-ix-057', 08:03:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:03 INFO - 'use_talos_json': True, 08:03:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:03 INFO - 'work_dir': 'build'} 08:03:03 INFO - ##### 08:03:03 INFO - ##### Running clobber step. 08:03:03 INFO - ##### 08:03:03 INFO - Running pre-action listener: _resource_record_pre_action 08:03:03 INFO - Running main action method: clobber 08:03:03 INFO - rmtree: /builds/slave/test/build 08:03:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:04 INFO - Running post-action listener: _resource_record_post_action 08:03:04 INFO - ##### 08:03:04 INFO - ##### Running read-buildbot-config step. 08:03:04 INFO - ##### 08:03:04 INFO - Running pre-action listener: _resource_record_pre_action 08:03:04 INFO - Running main action method: read_buildbot_config 08:03:04 INFO - Using buildbot properties: 08:03:04 INFO - { 08:03:04 INFO - "project": "", 08:03:04 INFO - "product": "firefox", 08:03:04 INFO - "script_repo_revision": "production", 08:03:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:03:04 INFO - "repository": "", 08:03:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:03:04 INFO - "buildid": "20160417053014", 08:03:04 INFO - "pgo_build": "True", 08:03:04 INFO - "basedir": "/builds/slave/test", 08:03:04 INFO - "buildnumber": 393, 08:03:04 INFO - "slavename": "talos-linux64-ix-057", 08:03:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:03:04 INFO - "platform": "ubuntu64_hw", 08:03:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:03:04 INFO - "branch": "fx-team", 08:03:04 INFO - "repo_path": "integration/fx-team", 08:03:04 INFO - "revision": "f8c0dd78206cac5a132b164ebacfa8ffbac9713c", 08:03:04 INFO - "stage_platform": "linux64-pgo", 08:03:04 INFO - "builduid": "4f6e1b8e0eeb4032bf98c50907d33de4", 08:03:04 INFO - "slavebuilddir": "test" 08:03:04 INFO - } 08:03:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:03:04 INFO - Running post-action listener: _resource_record_post_action 08:03:04 INFO - ##### 08:03:04 INFO - ##### Running download-and-extract step. 08:03:04 INFO - ##### 08:03:04 INFO - Running pre-action listener: _resource_record_pre_action 08:03:04 INFO - Running main action method: download_and_extract 08:03:04 INFO - mkdir: /builds/slave/test/build/tests 08:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:04 INFO - https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:03:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:03:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:03:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:03:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:03:12 INFO - Downloaded 1361 bytes. 08:03:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:03:12 INFO - Using the following test package requirements: 08:03:12 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:03:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:03:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:03:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:12 INFO - u'jsshell-linux-x86_64.zip'], 08:03:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:03:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:03:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:03:12 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:03:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:03:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:03:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:12 INFO - https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:03:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:03:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:03:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:03:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:03:28 INFO - Downloaded 23775046 bytes. 08:03:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:03:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:03:29 INFO - Return code: 0 08:03:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:03:29 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')]} 08:03:29 INFO - https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:03:32 INFO - Downloaded 23775046 bytes. 08:03:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:03:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:03:33 INFO - Return code: 0 08:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:33 INFO - https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:03:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:03:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:03:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:03:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:03:35 INFO - Downloaded 10841076 bytes. 08:03:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:03:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:03:35 INFO - Return code: 0 08:03: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')]} 08:03:35 INFO - https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:03:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:03:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:03:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:03:37 INFO - Downloaded 58243026 bytes. 08:03:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:03:37 INFO - mkdir: /builds/slave/test/properties 08:03:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:37 INFO - Contents: 08:03:37 INFO - build_url:https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:03:37 INFO - Running post-action listener: _resource_record_post_action 08:03:37 INFO - Running post-action listener: set_extra_try_arguments 08:03:37 INFO - ##### 08:03:37 INFO - ##### Running populate-webroot step. 08:03:37 INFO - ##### 08:03:37 INFO - Running pre-action listener: _resource_record_pre_action 08:03:37 INFO - Running main action method: populate_webroot 08:03:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:37 INFO - '--tppagecycles', 08:03:37 INFO - '7'], 08:03:37 INFO - 'tests': ['tsvgm']}}, 08:03:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:37 INFO - 'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:37 INFO - 'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['damp', 'tps']}, 08:03:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:37 INFO - 'tests': ['damp', 'tps']}, 08:03:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['dromaeo_dom']}, 08:03:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['a11yr', 08:03:37 INFO - 'ts_paint', 08:03:37 INFO - 'tpaint', 08:03:37 INFO - 'sessionrestore', 08:03:37 INFO - 'sessionrestore_no_auto_restore', 08:03:37 INFO - 'tabpaint']}, 08:03:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:37 INFO - 'ts_paint', 08:03:37 INFO - 'tpaint', 08:03:37 INFO - 'sessionrestore', 08:03:37 INFO - 'sessionrestore_no_auto_restore', 08:03:37 INFO - 'tabpaint']}, 08:03:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:37 INFO - 'ts_paint', 08:03:37 INFO - 'tpaint', 08:03:37 INFO - 'sessionrestore', 08:03:37 INFO - 'sessionrestore_no_auto_restore', 08:03:37 INFO - 'tabpaint']}, 08:03:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:37 INFO - 'ts_paint', 08:03:37 INFO - 'tpaint', 08:03:37 INFO - 'sessionrestore', 08:03:37 INFO - 'sessionrestore_no_auto_restore', 08:03:37 INFO - 'tabpaint']}, 08:03:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['a11yr', 08:03:37 INFO - 'ts_paint', 08:03:37 INFO - 'tpaint', 08:03:37 INFO - 'sessionrestore', 08:03:37 INFO - 'sessionrestore_no_auto_restore', 08:03:37 INFO - 'tabpaint']}, 08:03:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['a11yr', 08:03:37 INFO - 'ts_paint', 08:03:37 INFO - 'tpaint', 08:03:37 INFO - 'sessionrestore', 08:03:37 INFO - 'sessionrestore_no_auto_restore', 08:03:37 INFO - 'tabpaint']}, 08:03:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['tsvgx', 08:03:37 INFO - 'tsvgr_opacity', 08:03:37 INFO - 'tart', 08:03:37 INFO - 'tscrollx', 08:03:37 INFO - 'cart']}, 08:03:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:37 INFO - 'tsvgr_opacity', 08:03:37 INFO - 'tart', 08:03:37 INFO - 'tscrollx', 08:03:37 INFO - 'cart']}, 08:03:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:37 INFO - 'talos_options': ['--disable-e10s'], 08:03:37 INFO - 'tests': ['tp5o']}, 08:03:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:37 INFO - 'tests': ['tp5o']}, 08:03:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:37 INFO - 'talos_options': ['--disable-e10s', 08:03:37 INFO - '--xperf_path', 08:03:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:37 INFO - 'tests': ['tp5n']}, 08:03:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:37 INFO - 'talos_options': ['--xperf_path', 08:03:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:37 INFO - 'tests': ['tp5n']}}, 08:03:37 INFO - 'talos.zip': {'path': '', 08:03:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:37 INFO - Running post-action listener: _resource_record_post_action 08:03:37 INFO - ##### 08:03:37 INFO - ##### Running create-virtualenv step. 08:03:37 INFO - ##### 08:03:37 INFO - Running pre-action listener: _resource_record_pre_action 08:03:37 INFO - Running main action method: create_virtualenv 08:03:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03:37 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 08:03:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:37 INFO - Using real prefix '/usr' 08:03:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:40 INFO - Installing pip.................done. 08:03:40 INFO - Return code: 0 08:03:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:40 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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:40 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 08:03:40 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 08:03:40 INFO - Using env: {'DISPLAY': ':0', 08:03:40 INFO - 'HOME': '/home/cltbld', 08:03:40 INFO - 'LANG': 'en_US.UTF-8', 08:03:40 INFO - 'LANGUAGE': 'en_US:en', 08:03:40 INFO - 'LOGNAME': 'cltbld', 08:03:40 INFO - 'MAIL': '/var/mail/cltbld', 08:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:40 INFO - 'MOZ_NO_REMOTE': '1', 08:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:40 INFO - 'NO_EM_RESTART': '1', 08:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:40 INFO - 'PWD': '/builds/slave/test', 08:03:40 INFO - 'SHELL': '/bin/bash', 08:03:40 INFO - 'SHLVL': '1', 08:03:40 INFO - 'TERM': 'linux', 08:03:40 INFO - 'TMOUT': '86400', 08:03:40 INFO - 'USER': 'cltbld', 08:03:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:40 INFO - '_': '/tools/buildbot/bin/python'} 08:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:40 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 08:03:40 INFO - Cleaning up... 08:03:40 INFO - Return code: 0 08:03:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:40 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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:40 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 08:03:40 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 08:03:40 INFO - Using env: {'DISPLAY': ':0', 08:03:40 INFO - 'HOME': '/home/cltbld', 08:03:40 INFO - 'LANG': 'en_US.UTF-8', 08:03:40 INFO - 'LANGUAGE': 'en_US:en', 08:03:40 INFO - 'LOGNAME': 'cltbld', 08:03:40 INFO - 'MAIL': '/var/mail/cltbld', 08:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:40 INFO - 'MOZ_NO_REMOTE': '1', 08:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:40 INFO - 'NO_EM_RESTART': '1', 08:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:40 INFO - 'PWD': '/builds/slave/test', 08:03:40 INFO - 'SHELL': '/bin/bash', 08:03:40 INFO - 'SHLVL': '1', 08:03:40 INFO - 'TERM': 'linux', 08:03:40 INFO - 'TMOUT': '86400', 08:03:40 INFO - 'USER': 'cltbld', 08:03:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:40 INFO - '_': '/tools/buildbot/bin/python'} 08:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:40 INFO - Downloading/unpacking psutil>=0.7.1 08:03:40 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 08:03:40 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 08:03:40 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 08:03:40 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 08:03:40 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 08:03:40 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 08:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:42 INFO - Installing collected packages: psutil 08:03:42 INFO - Running setup.py install for psutil 08:03:42 INFO - building 'psutil._psutil_linux' extension 08:03:42 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 08:03:43 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 08:03:43 INFO - building 'psutil._psutil_posix' extension 08:03:43 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 08:03:43 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 08:03:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:43 INFO - Successfully installed psutil 08:03:43 INFO - Cleaning up... 08:03:43 INFO - Return code: 0 08:03:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:03:43 INFO - Using env: {'DISPLAY': ':0', 08:03:43 INFO - 'HOME': '/home/cltbld', 08:03:43 INFO - 'LANG': 'en_US.UTF-8', 08:03:43 INFO - 'LANGUAGE': 'en_US:en', 08:03:43 INFO - 'LOGNAME': 'cltbld', 08:03:43 INFO - 'MAIL': '/var/mail/cltbld', 08:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:43 INFO - 'MOZ_NO_REMOTE': '1', 08:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:43 INFO - 'NO_EM_RESTART': '1', 08:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:43 INFO - 'PWD': '/builds/slave/test', 08:03:43 INFO - 'SHELL': '/bin/bash', 08:03:43 INFO - 'SHLVL': '1', 08:03:43 INFO - 'TERM': 'linux', 08:03:43 INFO - 'TMOUT': '86400', 08:03:43 INFO - 'USER': 'cltbld', 08:03:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:43 INFO - '_': '/tools/buildbot/bin/python'} 08:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:03:43 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 08:03:43 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 08:03:43 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 08:03:43 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 08:03:43 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 08:03:43 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 08:03:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:03:45 INFO - Installing collected packages: mozsystemmonitor 08:03:45 INFO - Running setup.py install for mozsystemmonitor 08:03:45 INFO - Successfully installed mozsystemmonitor 08:03:45 INFO - Cleaning up... 08:03:45 INFO - Return code: 0 08:03:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:45 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 08:03:45 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 08:03:45 INFO - Using env: {'DISPLAY': ':0', 08:03:45 INFO - 'HOME': '/home/cltbld', 08:03:45 INFO - 'LANG': 'en_US.UTF-8', 08:03:45 INFO - 'LANGUAGE': 'en_US:en', 08:03:45 INFO - 'LOGNAME': 'cltbld', 08:03:45 INFO - 'MAIL': '/var/mail/cltbld', 08:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:45 INFO - 'MOZ_NO_REMOTE': '1', 08:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:45 INFO - 'NO_EM_RESTART': '1', 08:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:45 INFO - 'PWD': '/builds/slave/test', 08:03:45 INFO - 'SHELL': '/bin/bash', 08:03:45 INFO - 'SHLVL': '1', 08:03:45 INFO - 'TERM': 'linux', 08:03:45 INFO - 'TMOUT': '86400', 08:03:45 INFO - 'USER': 'cltbld', 08:03:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:45 INFO - '_': '/tools/buildbot/bin/python'} 08:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:45 INFO - Downloading/unpacking blobuploader==1.2.4 08:03:45 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 08:03:45 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 08:03:45 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 08:03:45 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 08:03:45 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 08:03:45 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 08:03:47 INFO - Downloading blobuploader-1.2.4.tar.gz 08:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:03:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:03:47 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 08:03:47 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 08:03:47 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 08:03:47 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 08:03:47 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 08:03:47 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 08:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:03:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:03:48 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 08:03:48 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 08:03:48 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 08:03:48 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 08:03:48 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 08:03:48 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 08:03:48 INFO - Downloading docopt-0.6.1.tar.gz 08:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:03:48 INFO - Installing collected packages: blobuploader, requests, docopt 08:03:48 INFO - Running setup.py install for blobuploader 08:03:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:03:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:03:48 INFO - Running setup.py install for requests 08:03:48 INFO - Running setup.py install for docopt 08:03:49 INFO - Successfully installed blobuploader requests docopt 08:03:49 INFO - Cleaning up... 08:03:49 INFO - Return code: 0 08:03:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:49 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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:49 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 08:03:49 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 08:03:49 INFO - Using env: {'DISPLAY': ':0', 08:03:49 INFO - 'HOME': '/home/cltbld', 08:03:49 INFO - 'LANG': 'en_US.UTF-8', 08:03:49 INFO - 'LANGUAGE': 'en_US:en', 08:03:49 INFO - 'LOGNAME': 'cltbld', 08:03:49 INFO - 'MAIL': '/var/mail/cltbld', 08:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:49 INFO - 'MOZ_NO_REMOTE': '1', 08:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:49 INFO - 'NO_EM_RESTART': '1', 08:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:49 INFO - 'PWD': '/builds/slave/test', 08:03:49 INFO - 'SHELL': '/bin/bash', 08:03:49 INFO - 'SHLVL': '1', 08:03:49 INFO - 'TERM': 'linux', 08:03:49 INFO - 'TMOUT': '86400', 08:03:49 INFO - 'USER': 'cltbld', 08:03:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:49 INFO - '_': '/tools/buildbot/bin/python'} 08:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:49 INFO - Running setup.py (path:/tmp/pip-mcQXSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:49 INFO - Running setup.py (path:/tmp/pip-JIjijz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:49 INFO - Running setup.py (path:/tmp/pip-jCpwbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:49 INFO - Running setup.py (path:/tmp/pip-m6qJlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:49 INFO - Running setup.py (path:/tmp/pip-a0aMnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:49 INFO - Running setup.py (path:/tmp/pip-CS6k0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:49 INFO - Running setup.py (path:/tmp/pip-MB975l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:49 INFO - Running setup.py (path:/tmp/pip-zi2yoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:49 INFO - Running setup.py (path:/tmp/pip-isQFzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:50 INFO - Running setup.py (path:/tmp/pip-8_esYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:50 INFO - Running setup.py (path:/tmp/pip-gLM0UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:50 INFO - Running setup.py (path:/tmp/pip-EbKrbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:50 INFO - Running setup.py (path:/tmp/pip-Tnoomj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:50 INFO - Running setup.py (path:/tmp/pip-cdbbeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:50 INFO - Running setup.py (path:/tmp/pip-_4itD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:50 INFO - Running setup.py (path:/tmp/pip-T9NJ3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:50 INFO - Running setup.py (path:/tmp/pip-xMPI3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:03:50 INFO - Running setup.py install for manifestparser 08:03:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:03:50 INFO - Running setup.py install for mozcrash 08:03:50 INFO - Running setup.py install for mozdebug 08:03:50 INFO - Running setup.py install for mozdevice 08:03:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:03:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:03:50 INFO - Running setup.py install for mozfile 08:03:51 INFO - Running setup.py install for mozhttpd 08:03:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Running setup.py install for mozinfo 08:03:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Running setup.py install for mozInstall 08:03:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Running setup.py install for mozleak 08:03:51 INFO - Running setup.py install for mozlog 08:03:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Running setup.py install for moznetwork 08:03:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Running setup.py install for mozprocess 08:03:51 INFO - Running setup.py install for mozprofile 08:03:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:03:51 INFO - Running setup.py install for mozrunner 08:03:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:03:52 INFO - Running setup.py install for mozscreenshot 08:03:52 INFO - Running setup.py install for moztest 08:03:52 INFO - Running setup.py install for mozversion 08:03:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:03:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:03:52 INFO - Cleaning up... 08:03:52 INFO - Return code: 0 08:03:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:52 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')]} 08:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:52 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')]} 08:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:52 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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:52 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 08:03:52 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 08:03:52 INFO - Using env: {'DISPLAY': ':0', 08:03:52 INFO - 'HOME': '/home/cltbld', 08:03:52 INFO - 'LANG': 'en_US.UTF-8', 08:03:52 INFO - 'LANGUAGE': 'en_US:en', 08:03:52 INFO - 'LOGNAME': 'cltbld', 08:03:52 INFO - 'MAIL': '/var/mail/cltbld', 08:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:52 INFO - 'MOZ_NO_REMOTE': '1', 08:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:52 INFO - 'NO_EM_RESTART': '1', 08:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:52 INFO - 'PWD': '/builds/slave/test', 08:03:52 INFO - 'SHELL': '/bin/bash', 08:03:52 INFO - 'SHLVL': '1', 08:03:52 INFO - 'TERM': 'linux', 08:03:52 INFO - 'TMOUT': '86400', 08:03:52 INFO - 'USER': 'cltbld', 08:03:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:52 INFO - '_': '/tools/buildbot/bin/python'} 08:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:52 INFO - Running setup.py (path:/tmp/pip-Ck6tYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:52 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)) 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:52 INFO - Running setup.py (path:/tmp/pip-u1J44S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:52 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)) 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:52 INFO - Running setup.py (path:/tmp/pip-eOgLQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:52 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)) 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:52 INFO - Running setup.py (path:/tmp/pip-UAlybY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:52 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)) 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:52 INFO - Running setup.py (path:/tmp/pip-eH8HC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:52 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)) 08:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:52 INFO - Running setup.py (path:/tmp/pip-sueC6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:53 INFO - Running setup.py (path:/tmp/pip-BXclFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:53 INFO - Running setup.py (path:/tmp/pip-_LS9tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:53 INFO - Running setup.py (path:/tmp/pip-mPCBLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:53 INFO - Running setup.py (path:/tmp/pip-7udbBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:53 INFO - Running setup.py (path:/tmp/pip-f8Uzpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:53 INFO - Running setup.py (path:/tmp/pip-dPSIAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:53 INFO - Running setup.py (path:/tmp/pip-MmLL5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:53 INFO - Running setup.py (path:/tmp/pip-T3ETVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:53 INFO - Running setup.py (path:/tmp/pip-teY3bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:53 INFO - Running setup.py (path:/tmp/pip-GOt9jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:53 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)) 08:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:53 INFO - Running setup.py (path:/tmp/pip-BuJVdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:53 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)) 08:03:53 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)) 08:03:53 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)) 08:03:53 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)) 08:03:53 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)) 08:03:53 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)) 08:03:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:55 INFO - Downloading blessings-1.6.tar.gz 08:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:03:55 INFO - Installing collected packages: blessings 08:03:55 INFO - Running setup.py install for blessings 08:03:55 INFO - Successfully installed blessings 08:03:55 INFO - Cleaning up... 08:03:55 INFO - Return code: 0 08:03:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:03:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:03:56 INFO - Reading from file tmpfile_stdout 08:03:56 INFO - Current package versions: 08:03:56 INFO - argparse == 1.2.1 08:03:56 INFO - blessings == 1.6 08:03:56 INFO - blobuploader == 1.2.4 08:03:56 INFO - docopt == 0.6.1 08:03:56 INFO - manifestparser == 1.1 08:03:56 INFO - mozInstall == 1.12 08:03:56 INFO - mozcrash == 0.17 08:03:56 INFO - mozdebug == 0.1 08:03:56 INFO - mozdevice == 0.48 08:03:56 INFO - mozfile == 1.2 08:03:56 INFO - mozhttpd == 0.7 08:03:56 INFO - mozinfo == 0.9 08:03:56 INFO - mozleak == 0.1 08:03:56 INFO - mozlog == 3.1 08:03:56 INFO - moznetwork == 0.27 08:03:56 INFO - mozprocess == 0.22 08:03:56 INFO - mozprofile == 0.28 08:03:56 INFO - mozrunner == 6.11 08:03:56 INFO - mozscreenshot == 0.1 08:03:56 INFO - mozsystemmonitor == 0.0 08:03:56 INFO - moztest == 0.7 08:03:56 INFO - mozversion == 1.4 08:03:56 INFO - psutil == 3.1.1 08:03:56 INFO - requests == 1.2.3 08:03:56 INFO - wsgiref == 0.1.2 08:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:56 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')]} 08:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:56 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')]} 08:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:56 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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:56 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 08:03:56 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 08:03:56 INFO - Using env: {'DISPLAY': ':0', 08:03:56 INFO - 'HOME': '/home/cltbld', 08:03:56 INFO - 'LANG': 'en_US.UTF-8', 08:03:56 INFO - 'LANGUAGE': 'en_US:en', 08:03:56 INFO - 'LOGNAME': 'cltbld', 08:03:56 INFO - 'MAIL': '/var/mail/cltbld', 08:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:56 INFO - 'MOZ_NO_REMOTE': '1', 08:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:56 INFO - 'NO_EM_RESTART': '1', 08:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:56 INFO - 'PWD': '/builds/slave/test', 08:03:56 INFO - 'SHELL': '/bin/bash', 08:03:56 INFO - 'SHLVL': '1', 08:03:56 INFO - 'TERM': 'linux', 08:03:56 INFO - 'TMOUT': '86400', 08:03:56 INFO - 'USER': 'cltbld', 08:03:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:56 INFO - '_': '/tools/buildbot/bin/python'} 08:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 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)) 08:03:56 INFO - Cleaning up... 08:03:56 INFO - Return code: 0 08:03:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:03:56 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')]} 08:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:56 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')]} 08:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:56 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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:56 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 08:03:56 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 08:03:56 INFO - Using env: {'DISPLAY': ':0', 08:03:56 INFO - 'HOME': '/home/cltbld', 08:03:56 INFO - 'LANG': 'en_US.UTF-8', 08:03:56 INFO - 'LANGUAGE': 'en_US:en', 08:03:56 INFO - 'LOGNAME': 'cltbld', 08:03:56 INFO - 'MAIL': '/var/mail/cltbld', 08:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:56 INFO - 'MOZ_NO_REMOTE': '1', 08:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:56 INFO - 'NO_EM_RESTART': '1', 08:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:56 INFO - 'PWD': '/builds/slave/test', 08:03:56 INFO - 'SHELL': '/bin/bash', 08:03:56 INFO - 'SHLVL': '1', 08:03:56 INFO - 'TERM': 'linux', 08:03:56 INFO - 'TMOUT': '86400', 08:03:56 INFO - 'USER': 'cltbld', 08:03:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:56 INFO - '_': '/tools/buildbot/bin/python'} 08:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:56 INFO - Downloading/unpacking jsonschema 08:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:03:58 INFO - Downloading/unpacking functools32 (from jsonschema) 08:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:58 INFO - Downloading functools32-3.2.3-2.tar.gz 08:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:03:58 INFO - warning: no files found matching '*.txt' 08:03:58 INFO - no previously-included directories found matching 'build' 08:03:58 INFO - no previously-included directories found matching 'dist' 08:03:58 INFO - no previously-included directories found matching '.git*' 08:03:58 INFO - Installing collected packages: jsonschema, functools32 08:03:58 INFO - Running setup.py install for functools32 08:03:58 INFO - warning: no files found matching '*.txt' 08:03:58 INFO - no previously-included directories found matching 'build' 08:03:58 INFO - no previously-included directories found matching 'dist' 08:03:58 INFO - no previously-included directories found matching '.git*' 08:03:58 INFO - Successfully installed jsonschema functools32 08:03:58 INFO - Cleaning up... 08:03:59 INFO - Return code: 0 08:03:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:59 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 0x7f2099eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', '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 08:03:59 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 08:03:59 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 08:03:59 INFO - Using env: {'DISPLAY': ':0', 08:03:59 INFO - 'HOME': '/home/cltbld', 08:03:59 INFO - 'LANG': 'en_US.UTF-8', 08:03:59 INFO - 'LANGUAGE': 'en_US:en', 08:03:59 INFO - 'LOGNAME': 'cltbld', 08:03:59 INFO - 'MAIL': '/var/mail/cltbld', 08:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:59 INFO - 'MOZ_NO_REMOTE': '1', 08:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:59 INFO - 'NO_EM_RESTART': '1', 08:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:59 INFO - 'PWD': '/builds/slave/test', 08:03:59 INFO - 'SHELL': '/bin/bash', 08:03:59 INFO - 'SHLVL': '1', 08:03:59 INFO - 'TERM': 'linux', 08:03:59 INFO - 'TMOUT': '86400', 08:03:59 INFO - 'USER': 'cltbld', 08:03:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:59 INFO - '_': '/tools/buildbot/bin/python'} 08:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:59 INFO - Downloading/unpacking flake8 08:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:04:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:04:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:01 INFO - no previously-included directories found matching 'docs/_build' 08:04:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:04:01 INFO - Running setup.py install for pep8 08:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:01 INFO - no previously-included directories found matching 'docs/_build' 08:04:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:04:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:04:01 INFO - Cleaning up... 08:04:02 INFO - Return code: 0 08:04:02 INFO - Running post-action listener: _resource_record_post_action 08:04:02 INFO - Running post-action listener: _start_resource_monitoring 08:04:02 INFO - Starting resource monitoring. 08:04:02 INFO - ##### 08:04:02 INFO - ##### Running install step. 08:04:02 INFO - ##### 08:04:02 INFO - Running pre-action listener: _resource_record_pre_action 08:04:02 INFO - Running main action method: install 08:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:02 INFO - Reading from file tmpfile_stdout 08:04:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:02 INFO - Reading from file tmpfile_stdout 08:04:02 INFO - Output received: 08:04:02 INFO - Usage: mozinstall [options] installer 08:04:02 INFO - Options: 08:04:02 INFO - -h, --help show this help message and exit 08:04:02 INFO - -d DEST, --destination=DEST 08:04:02 INFO - Directory to install application into. [default: 08:04:02 INFO - "/builds/slave/test"] 08:04:02 INFO - --app=APP Application being installed. [default: firefox] 08:04:02 INFO - mkdir: /builds/slave/test/build/application 08:04:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:04:18 INFO - Reading from file tmpfile_stdout 08:04:18 INFO - Output received: 08:04:18 INFO - /builds/slave/test/build/application/firefox/firefox 08:04:18 INFO - Running post-action listener: _resource_record_post_action 08:04:18 INFO - ##### 08:04:18 INFO - ##### Running run-tests step. 08:04:18 INFO - ##### 08:04:18 INFO - Running pre-action listener: _resource_record_pre_action 08:04:18 INFO - Running main action method: run_tests 08:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:18 INFO - Python 2.7.3 08:04:18 INFO - Return code: 0 08:04:18 INFO - grabbing minidump binary from tooltool 08:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa410>, '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 0xefb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:18 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 08:04:18 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 08:04:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:18 INFO - Return code: 0 08:04:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:04:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:04:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:04:19 INFO - Return code: 0 08:04:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:04:19 INFO - Using env: {'DISPLAY': ':0', 08:04:19 INFO - 'HOME': '/home/cltbld', 08:04:19 INFO - 'LANG': 'en_US.UTF-8', 08:04:19 INFO - 'LANGUAGE': 'en_US:en', 08:04:19 INFO - 'LOGNAME': 'cltbld', 08:04:19 INFO - 'MAIL': '/var/mail/cltbld', 08:04:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:19 INFO - 'MOZ_NO_REMOTE': '1', 08:04:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:19 INFO - 'NO_EM_RESTART': '1', 08:04:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:19 INFO - 'PWD': '/builds/slave/test', 08:04:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:19 INFO - 'SHELL': '/bin/bash', 08:04:19 INFO - 'SHLVL': '1', 08:04:19 INFO - 'TERM': 'linux', 08:04:19 INFO - 'TMOUT': '86400', 08:04:19 INFO - 'USER': 'cltbld', 08:04:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042', 08:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:19 INFO - '_': '/tools/buildbot/bin/python'} 08:04:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:04:20 INFO - mozversion application_buildid: 20160417053014 08:04:20 INFO - mozversion application_changeset: f8c0dd78206cac5a132b164ebacfa8ffbac9713c 08:04:20 INFO - mozversion application_display_name: Nightly 08:04:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:20 INFO - mozversion application_name: Firefox 08:04:20 INFO - mozversion application_remotingname: firefox 08:04:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:04:20 INFO - mozversion application_vendor: Mozilla 08:04:20 INFO - mozversion application_version: 48.0a1 08:04:20 INFO - mozversion platform_buildid: 20160417053014 08:04:20 INFO - mozversion platform_changeset: f8c0dd78206cac5a132b164ebacfa8ffbac9713c 08:04:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:04:20 INFO - mozversion platform_version: 48.0a1 08:04:20 INFO - using testdate: 1460905460 08:04:20 INFO - actual date: 1460905460 08:04:20 INFO - starting webserver on 'localhost:42422' 08:04:20 INFO - SUITE-START | Running 2 tests 08:04:20 INFO - TEST-START | dromaeo_css 08:04:20 INFO - operating with platform_type : linux_ 08:04:20 INFO - Initialising browser for dromaeo_css test... 08:04:20 INFO - TEST-INFO | started process 1496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLTTwkz/profile http://localhost:42422/getInfo.html) 08:04:23 INFO - PROCESS | 1496 | 08:04:23 INFO - PROCESS | 1496 | (process:1566): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:04:24 INFO - PROCESS | 1496 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:04:24 INFO - PROCESS | 1496 | __metrics Screen width/height:1600/1200 08:04:24 INFO - PROCESS | 1496 | colorDepth:24 08:04:24 INFO - PROCESS | 1496 | Browser inner width/height: 1024/697 08:04:24 INFO - PROCESS | 1496 | __metrics 08:04:25 ERROR - PROCESS | 1496 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:04:26 INFO - TEST-INFO | 1496: exit 0 08:04:26 INFO - Browser initialized. 08:04:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:26 INFO - TEST-INFO | started process 1617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLTTwkz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:27 INFO - PROCESS | 1617 | 08:04:27 INFO - PROCESS | 1617 | (process:1676): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:04:37 INFO - PROCESS | 1617 | RSS: Main: 163475456 08:04:37 INFO - PROCESS | 1617 | 08:05:27 INFO - PROCESS | 1617 | 1460905527468 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] 08:07:35 INFO - PROCESS | 1617 | Cycle 1(1): loaded http://localhost:42422/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42422/tests/dromaeo/cssquery-ext.html) 08:07:36 INFO - PROCESS | 1617 | RSS: Main: 169000960 08:07:36 INFO - PROCESS | 1617 | 08:10:38 INFO - PROCESS | 1617 | Cycle 1(1): loaded http://localhost:42422/tests/dromaeo/cssquery-ext.html (next: http://localhost:42422/tests/dromaeo/cssquery-jquery.html) 08:10:39 INFO - PROCESS | 1617 | RSS: Main: 165122048 08:10:39 INFO - PROCESS | 1617 | 08:13:40 INFO - PROCESS | 1617 | Cycle 1(1): loaded http://localhost:42422/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42422/tests/dromaeo/cssquery-mootools.html) 08:13:41 INFO - PROCESS | 1617 | RSS: Main: 166531072 08:13:41 INFO - PROCESS | 1617 | 08:16:43 INFO - PROCESS | 1617 | Cycle 1(1): loaded http://localhost:42422/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42422/tests/dromaeo/cssquery-prototype.html) 08:16:43 INFO - PROCESS | 1617 | RSS: Main: 164282368 08:16:43 INFO - PROCESS | 1617 | 08:19:46 INFO - PROCESS | 1617 | Cycle 1(1): loaded http://localhost:42422/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42422/tests/dromaeo/cssquery-yui.html) 08:19:46 INFO - PROCESS | 1617 | RSS: Main: 165380096 08:19:46 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | Cycle 1(1): loaded http://localhost:42422/tests/dromaeo/cssquery-yui.html (next: http://localhost:42422/tests/dromaeo/cssquery-dojo.html) 08:22:49 INFO - PROCESS | 1617 | RSS: Main: 167018496 08:22:49 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | __start_tp_report 08:22:49 INFO - PROCESS | 1617 | _x_x_mozilla_page_load 08:22:49 INFO - PROCESS | 1617 | _x_x_mozilla_page_load_details 08:22:49 INFO - PROCESS | 1617 | |i|pagename|runs| 08:22:49 INFO - PROCESS | 1617 | |0;dojo.html;3063.218879185808;3131.311111555457;3135.482645363515;3170.9524357134633;3172.397244523539;5350.946490535093;5382.91925621116;5396.865078373043;5398.811041613544;5403.6487628304185;5277.973610131944;5392.110301800208;5443.101888188454;5568;5592.720363981794;4856.465788763233;4885.682430642015;4931.457539670633;4960.87597810054;5002.424721157077;4864.878378040559;4925.630577706668;4971;4985.775640096186;5049.267856160873;4816.903661926759;4852.393450818648;4868.805247790084;4893.412790465131;4939.876503087434;4842.297866809293;4859.73271470069;4868.269759536062;4874.683145595561;4891.804327826882;4816.759162041884;4838.371011768448;4843;4860.489648586883;4865.537773911473;5128.769205385729;5264.578833693296;5323.414424413311;5333.439988801198;5376.4085950545405;5788.9290481261105;5800.709964501758;5812.651240925558;5844.941550584483;5880.941190588125;5754.769809207627;5795.362510123883;5885.4997325227405;5889.558283128739;5890.617109887844;5359.598030147755;5410.594205434569;5415.431379705153;5427.3215848019;5467.316585426822;5918.171455996164;5926.436988486087;5973.522118230531;5983.940160598426;5984.640921544721;5522.144067669517;5639.210510528529;5702.344230413472;5744.195812586241;5744.971275143597;5741.885162296814;5841.795537156264;5849.883002340014;5853.853653658693;5901.114832775118;5611.831645050655;5680.886382272414;5790.536757059425;5797.449242321973;5865.6480611162615;5645.491905728504;5761.452661997104;5817.360090390053;5819.098039803837;5857.648541087548;4264.04059086703;4271.402003719481;4328.199283132568;4402.405675233803;4443.37792709021;3892.4550562921213;3913.2369188008634;3915.158240978203;3925.8961014430283;3959.5842436544326;5514.476124768141;5545.528630066409;5566.666000040011;5602.467765562265;5623.184638227516;5728.341240757366;5797.913031304533;5819.592628516048;5873;5907.763689452374;5639.464250896241;5663.716814159276;5668.461496157858;5671.914921276184;5673.914891276634;4772.546608072227;4992.101421744121;4992.525710057539;5002.099622068063;5018.04657115147;5950.2264705587995;6070.575059745775;6102.883130681719;6107.12812945598;6124.724387402489;5724.341700704473;5755.8273251801675;5762.769489220552;5789.8263052108505;5792.884142317046;5881.441263080001;5888.735006924613;5971.7611295547695;5982.312034116132;5993.460588547052;5673.319201695823;5686.203931449683;5692.971535142297;5696.344920334214;5749.453801888814;5652.236948011966;5772.1341798728845;5779.711014449176;5788.623739456922;5790.305163380252;5516.3380394352935;5561.499465048165;5572.3034620672415;5596.440355964371;5605.635633683961;5583.497485226349;5612.522935550524;5617.88764224705;5645.745941432728;5649.237352957298;5582.469665381782;5597.44025597437;5609.663420194802;5609.747561359667;5626.803061892814;5568.888622227451;5674.914876276776;5698.572607054571;5729.427057294237;5793.91309130355;5529.612927095065;5598;5614.2701448811395;5627.662340259598;5637.351704553865 08:22:49 INFO - PROCESS | 1617 | |1;ext.html;597.6055803169909;649.3474058571136;658.5456035335618;671.0873212431094;689.4725534965755;31999.160100787907;32764;33280;34032.31935361295;34537;37978.8101059495;38148.61851381485;38584.80707596465;38632.613673863256;38670.419943700865;8333.125021872722;8464.32285417165;8467.407281490297;8498.660053597849;8507.234348908598;8246.958765206165;8566.914330856674;8567.057623661392;8625.827483450326;8653.307735381155;8631.395802293842;8647.221750042494;8722.12778722129;8727.301815854747;8730.301575873915;8597.828043439127;8629.482231066157;8633.438826476291;8658.740237792876;8666;8516.23353898146;8570.914290857074;8648.783780405478;8653.783655408664;8716.956415217883;32318.19204519906;35029.47455788165;35431.645683543094;36130.45804312911;36198.81900590507;3102.177922850424;3117.2206948262933;3314.5028245763087;3739.439084137401;3818.274527839729;30152.54771178434;30655.846720766476;30887;31049;31535;4165.520965089023;4172.395002724618;4217.8312867485265;4262.46719160105;4297.140571885635;293573;295498;299303;299792;301717;36682.44976325357;62154;62265.377346226865;62823.68588157121;62955.37044629495;36679;36905.630943690754;36953.630463695554;36984.63015369866;37118.44322335167;14017.579472615838;14019.158850469004;14075.577732668036;14079.577612671636;14169.504067357593;11268.267562608404;11350.318980861175;11395.088392928712;11418;11441;8594.312455003585;8778.341624378198;8818;8831.64673413069;8847.557622118868;3146.8269245191277;3182.299894023311;3191.6010498687665;3227.951580726291;3242.5460435539044;1094.529352378469;1132.1395739238237;1150.4995327032768;1177.9823302650468;1184.0350114656528;31912.202194945312;32092.518612220836;32171.51742723861;32283.677163228538;32972.3405531888;1089.9945500272447;1112.5382966069153;1129.282905355089;1136.1882427917762;1183.2308999150448;14951.102933824006;15014.699706005818;15173.620659483602;15637.921810390875;15757.921210394104;205996;206627;207191;207712;207915;55325;55864;56285.437145628835;56568.43431565714;57116;1328.110166188656;1372.1766939836018;1373.9450421983208;1378.0491460891953;1477.8743806776329;29085.85457072701;29357;29500.704992949795;29954.70045299606;30734.538981915735;46245.53754462547;46272.30591541062;46297.537024629324;46823.76588117037;46997;405111;406602;408149;408376;409872;28208;28747.425051498434;28763.85618071896;28779.424411511234;37082.25835483329;41422.1715565681;41563;41679.374809377274;41701.1659766809;43124;37954.81022594869;38747.806260968515;38804.6119538801;38826.80586597162;38900.80549597234;37557.4366384499;39097.41353879637;41316;41933.58066419297;42619;39992.2001559973;40564;42159.578404216794;43202.567974319856;43484.78257608692;33025;34440.48339274963;34539.48190777191;34612.9616111517;35108.824455877555;27010.72989270082;27574.172774816787;27918;28040.158795236177;28580.714192857806 08:22:49 INFO - PROCESS | 1617 | |2;jquery.html;385.3641491538962;395.28650785332474;400.17963175490246;400.44138426894466;407.75534679192486;14072.577822665311;17493.300267989263;18303;18389.816101838995;18589.44231673052;18106.909465452653;18303.816961830376;18621.44135675932;18986.810131898677;19087;5501.504864562188;5559.833205003846;5713.685747283897;5735.283089613798;5749.56878234132;5704.286964129484;5710.029295019856;5716.428357164271;5729.0833466645345;5743.3108027036815;5495.835124946258;5683.431656834304;5686.260786097801;5689;5720.513756330696;5466.8359949201185;5675.914861277063;5678.43215678433;5683.204351390808;5700.37295897451;5066.645334826564;5099.311592934943;5101;5101.387833459971;5101.795928162869;20649.58700825975;20721.27475538349;20803;20922.686159707617;21786.34640960758;2029.4926268432891;2183.257692384597;2214.944626384337;2306.7923886850263;2638.1162310625964;9334;9749.07383798538;10192.388456692548;11265.26775759573;13611.591652250449;1839.8620103492292;1888.6317168152216;1908.4656296237076;1938.6898096304524;1939.8933058681766;67723.66138169277;69015.3098469014;69640.30359696389;70061.2993870065;71383;9863.605455781832;10145.08694217524;10213.33613315147;10301.74245643865;10415.739606509898;13174.802377964339;13822.516211932534;13844.861551384558;13969.231692257023;14029.85970140306;7465.7013719450615;7624.847503049908;7669.156392796788;7686.270589117516;7927.643256053491;7216.7474138404905;7318.890216646648;7330.523515971445;7384.815379615553;7467.066616672916;4399.12017596482;4440.866773996785;4479.328100784843;4498.785327961497;4509.842155524541;1818.7999320074782;1837.9356722514647;1901.657701613695;1926.5568919148675;1934.4003358958769;995.3082607587658;1036.6164519127972;1132.5356603792407;1162.3665102518978;1186.8397766301612;18409.447716568524;18792.342268020555;18976.620467590572;19388.515287117934;19577.510562235773;1008.2690049713899;1034.5034383495813;1070.9946450267855;1108.1356541897333;1109.8723646780722;10493.160547156209;10995.230333876712;11006.504707288192;11065.889341106647;11145.944270278758;466624;467895;470119;471182;488979;82495.58752206201;84622;89002;89044.5547772257;90844.54577727069;1030.8041472120274;1042.0777611813448;1078.2883297023927;1096.331237944853;1102.4653043274006;16355.427560035341;16889.915550422662;17070.48788536346;17110.914445427694;17274.222659980078;30281;37072.629273706916;37743.433848491746;38619.42070868883;39089.609103908595;50018.249726254864;51054;51095.489045109076;51921.48078519166;52548.211776824144;8471;8716.084811094745;8772.605232764414;8807.91192088071;8880.978687450768;12775.808362874379;13274.800877986645;13464.663383415493;13550.796738049134;13700.93149534246;11172.217944744116;12109.212901161396;12222.327771972627;12349.69125771827;12365.505379785067;11672.358020308964;11760.705982350168;11770.293782373084;11981.221220620631;12051.51793928233;12143.817842732542;12171.878281217074;12212.450439730055;12331.198472099284;12456.439460224494;7255.56466612005;7641.235876412315;7907.525548467111;7966.083900351302;8589;10458.47707614601;10924.12606991423;11131.499082541468;11690.4739286734;11840.76318473643 08:22:49 INFO - PROCESS | 1617 | |3;mootools.html;1494.0512774388267;1522.2160587297544;1659.3777333499938;1710.5296043588019;1792.8834625749334;7482.102147742278;8023.478473899199;8065.072516660586;8321.542315172663;8364.372672049598;8006.1193268740535;8009.439339246255;8084.2724154826055;8095.757127286191;8102.675892964275;2231.6317807561772;2244.3267019894047;2265.3317271404976;2267.9319620411416;2273.374821923976;2221.911123555056;2233.8883055847223;2241.2827895073583;2250.324902529243;2254.6392577187653;2265.1732117777055;2268.625676763332;2274.4882401459704;2291.0835665733757;2298.586254474194;2165.621016322153;2166.068590506082;2181.4764456530397;2191.6493361062235;2198.1537108213292;2131.467133216696;2149;2154.2352464875057;2158.665406861939;2161.8054375106317;8238;8322.958385208096;8337;8338.374621903382;8362.331013518904;4696.647751418657;4837.8306759263605;4878.390201224847;4887.584555312803;4926.4088309403105;2932.618759561243;3040.300730831899;3085.8765649374;3098.2719061020643;3116.766242531819;1000.8448690452918;1002.6540843409012;1005.8843233028149;1039.3192458939332;1041.0994489766374;11055.22613417061;11070.225084244106;11096.55613775448;11106.500207490682;11133.944330278297;4247.256730072225;4297.484301883794;4399.318105693623;4457.732536047847;4461.263891457938;9422.34043616954;9424.670136545188;9460.243180545678;9472.05279472061;9487.193588545051;4678.2982552616695;4717.268823332389;4719.834805781781;4728.787204575802;4747.2879068140055;4006.639402453793;4279.614834664895;4375.299952007664;4402.185595664812;4408.316710909814;3824.521934758155;3839.3856982883162;3946.408038794204;3976.8608098716986;3992.720509564361;1265.8670839561898;1299.0711641176604;1306.8105124756858;1312.8030795380769;1321.7951217561294;853.2789792625346;872.5549969515466;919.72868003939;928.967486137982;931.2224292715658;5574.804881829197;5597.6641401516035;5726.341470730919;5741.770329186869;5780.814932938738;908.1826356279402;957.3394357893031;965.0976337124811;981.2787601113176;987.4470296633908;3793.0896584819443;3822.140018495872;3836.501254836909;3857.8263978121054;3862;9808;10013.749656258651;10096.848547271797;10106.39361638304;10187.235957303084;10116.54475548602;10128.848067278997;10162.4918754062;10175.745606359753;10182;7660.080790305199;7665.540067595962;7670.501417407962;7727.265909738566;7876.645550950221;5589.413111623221;5600.663960162403;5601.6358936668985;5667.20659107717;5733.598648094593;9141.817163656557;9197.310201734763;9365.531723413666;9381.530923453936;9404.247660187031;9207.723768286962;9314.778897403787;9384.436933783994;9453;9484.810303794024;6694.4644428444635;6762.188537375547;6904.689288982108;6990.685419156252;7078.575285482888;8092.393070519617;8111.75664730059;8116.75649730509;8154.796130096795;8163.387745919199;7069.505134640526;7290.963545182452;7321.341079302888;7367.63161841895;7446.813829654302;6813.148356455443;6821.147356580427;6838.076859623887;6890.069840571458;6936.543325901617;6429.196350456193;6531.379518945692;6630.469562434897;6673.499487538357;6686.765963191265;5041.571466425395;5068.239764035424;5124;5134.12719837621;5141.2288156776785;5160.251763494197;5222.869428264172;5243.764030618708;5291.417944026077;5324.094903866429 08:22:49 INFO - PROCESS | 1617 | |4;prototype.html;312.08870099310025;318.80393557961855;323.7248338911924;329.1113992221004;329.4152878640413;5816.185733997244;5937.435943585363;5973.133895585143;5973.283206015273;6005.9189345917775;5890.764369425217;5948.31594366648;5948.970255148729;5999.910001349972;6003.369646187153;4438.511763705989;4526.343680166374;4540.79566419512;4562.634989200873;4564.703294285878;4402.3176407656865;4536.637069034469;4550.613197878184;4557.339185818055;4560.110778398213;4470.485894122169;4473.575010374009;4483.461984561857;4494.719005083552;4496.235639941217;4498.740352701233;4500.437445319335;4505.684602077856;4517.5215084385;4523.298888672228;3840.385538313856;3936.665383442411;3954.940675889864;3958.34687276599;3959.821808018617;5613.831585052455;5689.743961521742;5707.4031315751645;5716.228309178291;5760.481556659879;5161.3806343238675;5174;5177.498525427659;5210.218467229908;5213.4004589472315;6036.879262414727;6216.533759968021;6223.813285601439;6240;6262.499000079983;4293.141371725667;4328.740275583444;4338.110687309094;4354.259775838115;4354.259775838115;6377.681115944184;6513.446357059655;6540.607563546155;6543.5461701861805;6555.3772391622715;4436.3567282743825;4443.7111587746695;4451.399061126771;4474.977625111854;4488.326750987378;4444.177827101997;4444.511103778582;4483.2826747720865;4493.7977790999485;4529.4599836055895;5217.321748172713;5232.633715639945;5235.764390602432;5240.842774716764;5248.134057880483;5988.526654540443;6006.789762358384;6089.330173680892;6225.8132256032395;6322.683865806691;1530.6096945279105;1549.7520396736468;1554.875609951201;1556.2452210677811;1558.9532314030598;1000.3197825478744;1013.6958912326272;1020.3826684855555;1028.5320179318392;1036.7149034015706;6115.379424452523;6129.08063790435;6134.754609815557;6144.988955411816;6174.876502470015;6442.549021568445;6456.709448074848;6485.092087107809;6492.156019717407;6508.967455162694;5998.430149135826;6023.3073196582955;6081.239845019372;6098.176746139215;6176.8764624707255;3451.6548345165784;3454.7236221102253;3495.8951231463097;3498;3499.9125021874656;6553.803385898431;6708.899366509506;6716.361945615159;6725.024871393621;6763.2898545652;6548.246951600627;6578.868422631521;6582.901256481156;6584.078229047937;6589.242237142694;6595.175603049619;6693.698783554752;6720.1599800025;6755.392014718601;6759.188897332351;6463.25672547663;6465.77369792055;6474.805755827333;6484.1894763154605;6514.9348506514325;6252.905741495311;6360.236771587254;6402.5518213726455;6410;6410.839729006812;6692;6715.160604924385;6727.394534491919;6751.358620931003;6783.762568310085;4346.65226781863;4353.673474489363;4380.9780951095045;4385.232584297799;4391.64866810648;6280.874382512416;6291.748330066929;6485.156929599122;6503.707333169924;6552.1154644124335;6253.812385628438;6290.748370065146;6352.9047064293145;6384.201974753156;6384.840378990562;6119.969400152971;6272.4982001440685;6277.591956522811;6318.968405158129;6330.620162790247;6200.844978875564;6235.594686345373;6237.157983672146;6239.407256310643;6250.281217660027;6360.554761166674;6373.840653983688;6399.55203135776;6423.646699431576;6432.614043157426;5922.851928701817;6157;6169.660668663267;6170.10533472653;6282.1519094921605 08:22:49 INFO - PROCESS | 1617 | |5;yui.html;766.2337662337666;771.1478815908421;793.6428607126794;794.301015106706;802.6909639788681;11959.521619135236;11987.220830646002;12084.274943503386;12140.453679584418;12224.083193760482;11105;12074.215176013575;12365.319907405112;12380.319082450462;12387.752244955096;677.1366507702669;796.4623878881761;824.8638974569188;827.8302947895697;831.7047448155909;818.8075802186481;820.0159808230118;820.1388542030844;820.9630566624486;823.2467292427422;856.2764464027887;858.171864151094;859.4542465534399;860.6127242740761;861.1775754154767;850.9574521273912;851.5742128935532;855.683397143058;856.9400141990094;857.536930057768;620.534599050712;620.5935112501319;622.8349487385847;624.9750009999594;625.9092431597438;12326.137170398075;12424.689382765504;12437.875621243762;12445.502179912794;12494.250344979331;10844.783104337948;10928.344299342065;11107.278026928305;11175.553973524698;11214.719632009264;8935.731928042169;8998.14517620825;9020.639174433014;9024.23294020009;9117.22503587196;3184.45864203086;3238.4656531672244;3287.8027318360737;3292.7530435217454;3329.250918543333;60615.393846061415;60775.088373673985;61264.567220441655;61725;61847.38152618461;8667.349948753868;8888.60001299943;9014.86477702835;9150.63397464094;9275.860862087075;17085.65828683444;17103.828961710224;17282.04948727807;17334.306627735;17340.566485837702;6767.221769496472;6826.795196144124;6875.449964002868;7071.398931090812;7185.209626941137;4006.1787333597126;4033.4779666414693;4075.062735570776;4107.835686572504;4119.279126152911;3029.9545506817417;3133.091403493007;3138.2468207630004;3141.104785136225;3146.6381366142728;559.3288054334814;565.3780841074868;568.2101878389043;575.1085816983658;575.9798407055733;637.0635166305616;654.6759005530348;671.4896678524259;675.783749200261;677.1332694151494;7830.569318687527;8075.152109028468;8205.83588328242;8260.669573217125;8390.454620449651;633.8415396150963;663.4824836627438;668.1814776898261;672.4418732452053;679.3647939176885;3732.8320225589914;3859.729818912649;3915.7063220258024;3963.6432721055244;3981.7610943343493;53735.462645373045;55592.444075559535;67135;67247.32752672509;67374.32625673778;45417.31874021892;51446.59810719895;51492.48507514877;52390.47609523932;53657.463425366026;36749.08127296786;39621;40249;46073.7696311523;48825.26762098642;7900.486468379537;7902.4863383879865;8009.479383840032;8208.542976156725;8294.502329860228;29163.562546561396;29715.405691886474;29737.702622973495;34117.905851298005;34349.82825085858;42584.57415425806;42638.786806067015;42684;43298.78350608227;43656.78171609122;11114.49984750672;11150.386728729673;11229.3262404256;11360.261582997078;11600;10986.285891417032;11197.104231661611;11307.321560706385;11464.541418343506;11569.6529104127;10157.238207134642;10218.591256349662;10291.742706432398;10724;10956.178286628694;10649.414282214553;10736.409497477402;10781.137508999105;10919.181061420266;11191.496382662637;10071.546780395047;10358.326708763907;10390.22073344487;10464;10498.160147188053;9190;9223.354365194373;9282.814343712953;9379.484128372733;9470.479123648265;9459.479728614991;9668.993020937189;9699.806003879741;9700.223982081558;9811.656592019244 08:22:49 INFO - PROCESS | 1617 | __end_tp_report 08:22:49 INFO - PROCESS | 1617 | __start_cc_report 08:22:49 INFO - PROCESS | 1617 | _x_x_mozilla_cycle_collect,341 08:22:49 INFO - PROCESS | 1617 | __end_cc_report 08:22:49 INFO - PROCESS | 1617 | __startTimestamp1460906569393__endTimestamp 08:22:49 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | ------- Summary: start ------- 08:22:49 INFO - PROCESS | 1617 | Number of tests: 6 08:22:49 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | [#0] dojo.html Cycles:165 Average:5376.38 Median:5609.75 stddev:626.19 (11.2%) stddev-sans-first:601.25 08:22:49 INFO - PROCESS | 1617 | Values: 3063.2 3131.3 3135.5 3171.0 3172.4 5350.9 5382.9 5396.9 5398.8 5403.6 5278.0 5392.1 5443.1 5568.0 5592.7 4856.5 4885.7 4931.5 4960.9 5002.4 4864.9 4925.6 4971.0 4985.8 5049.3 4816.9 4852.4 4868.8 4893.4 4939.9 4842.3 4859.7 4868.3 4874.7 4891.8 4816.8 4838.4 4843.0 4860.5 4865.5 5128.8 5264.6 5323.4 5333.4 5376.4 5788.9 5800.7 5812.7 5844.9 5880.9 5754.8 5795.4 5885.5 5889.6 5890.6 5359.6 5410.6 5415.4 5427.3 5467.3 5918.2 5926.4 5973.5 5983.9 5984.6 5522.1 5639.2 5702.3 5744.2 5745.0 5741.9 5841.8 5849.9 5853.9 5901.1 5611.8 5680.9 5790.5 5797.4 5865.6 5645.5 5761.5 5817.4 5819.1 5857.6 4264.0 4271.4 4328.2 4402.4 4443.4 3892.5 3913.2 3915.2 3925.9 3959.6 5514.5 5545.5 5566.7 5602.5 5623.2 5728.3 5797.9 5819.6 5873.0 5907.8 5639.5 5663.7 5668.5 5671.9 5673.9 4772.5 4992.1 4992.5 5002.1 5018.0 5950.2 6070.6 6102.9 6107.1 6124.7 5724.3 5755.8 5762.8 5789.8 5792.9 5881.4 5888.7 5971.8 5982.3 5993.5 5673.3 5686.2 5693.0 5696.3 5749.5 5652.2 5772.1 5779.7 5788.6 5790.3 5516.3 5561.5 5572.3 5596.4 5605.6 5583.5 5612.5 5617.9 5645.7 5649.2 5582.5 5597.4 5609.7 5609.7 5626.8 5568.9 5674.9 5698.6 5729.4 5793.9 5529.6 5598.0 5614.3 5627.7 5637.4 08:22:49 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | [#1] ext.html Cycles:180 Average:46455.67 Median:36969.13 stddev:83150.52 (224.9%) stddev-sans-first:83312.49 08:22:49 INFO - PROCESS | 1617 | Values: 597.6 649.3 658.5 671.1 689.5 31999.2 32764.0 33280.0 34032.3 34537.0 37978.8 38148.6 38584.8 38632.6 38670.4 8333.1 8464.3 8467.4 8498.7 8507.2 8247.0 8566.9 8567.1 8625.8 8653.3 8631.4 8647.2 8722.1 8727.3 8730.3 8597.8 8629.5 8633.4 8658.7 8666.0 8516.2 8570.9 8648.8 8653.8 8717.0 32318.2 35029.5 35431.6 36130.5 36198.8 3102.2 3117.2 3314.5 3739.4 3818.3 30152.5 30655.8 30887.0 31049.0 31535.0 4165.5 4172.4 4217.8 4262.5 4297.1 293573.0 295498.0 299303.0 299792.0 301717.0 36682.4 62154.0 62265.4 62823.7 62955.4 36679.0 36905.6 36953.6 36984.6 37118.4 14017.6 14019.2 14075.6 14079.6 14169.5 11268.3 11350.3 11395.1 11418.0 11441.0 8594.3 8778.3 8818.0 8831.6 8847.6 3146.8 3182.3 3191.6 3228.0 3242.5 1094.5 1132.1 1150.5 1178.0 1184.0 31912.2 32092.5 32171.5 32283.7 32972.3 1090.0 1112.5 1129.3 1136.2 1183.2 14951.1 15014.7 15173.6 15637.9 15757.9 205996.0 206627.0 207191.0 207712.0 207915.0 55325.0 55864.0 56285.4 56568.4 57116.0 1328.1 1372.2 1373.9 1378.0 1477.9 29085.9 29357.0 29500.7 29954.7 30734.5 46245.5 46272.3 46297.5 46823.8 46997.0 405111.0 406602.0 408149.0 408376.0 409872.0 28208.0 28747.4 28763.9 28779.4 37082.3 41422.2 41563.0 41679.4 41701.2 43124.0 37954.8 38747.8 38804.6 38826.8 38900.8 37557.4 39097.4 41316.0 41933.6 42619.0 39992.2 40564.0 42159.6 43202.6 43484.8 33025.0 34440.5 34539.5 34613.0 35108.8 27010.7 27574.2 27918.0 28040.2 28580.7 08:22:49 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | [#2] jquery.html Cycles:180 Average:27515.07 Median:21354.52 stddev:77746.84 (364.1%) stddev-sans-first:77938.26 08:22:49 INFO - PROCESS | 1617 | Values: 385.4 395.3 400.2 400.4 407.8 14072.6 17493.3 18303.0 18389.8 18589.4 18106.9 18303.8 18621.4 18986.8 19087.0 5501.5 5559.8 5713.7 5735.3 5749.6 5704.3 5710.0 5716.4 5729.1 5743.3 5495.8 5683.4 5686.3 5689.0 5720.5 5466.8 5675.9 5678.4 5683.2 5700.4 5066.6 5099.3 5101.0 5101.4 5101.8 20649.6 20721.3 20803.0 20922.7 21786.3 2029.5 2183.3 2214.9 2306.8 2638.1 9334.0 9749.1 10192.4 11265.3 13611.6 1839.9 1888.6 1908.5 1938.7 1939.9 67723.7 69015.3 69640.3 70061.3 71383.0 9863.6 10145.1 10213.3 10301.7 10415.7 13174.8 13822.5 13844.9 13969.2 14029.9 7465.7 7624.8 7669.2 7686.3 7927.6 7216.7 7318.9 7330.5 7384.8 7467.1 4399.1 4440.9 4479.3 4498.8 4509.8 1818.8 1837.9 1901.7 1926.6 1934.4 995.3 1036.6 1132.5 1162.4 1186.8 18409.4 18792.3 18976.6 19388.5 19577.5 1008.3 1034.5 1071.0 1108.1 1109.9 10493.2 10995.2 11006.5 11065.9 11145.9 466624.0 467895.0 470119.0 471182.0 488979.0 82495.6 84622.0 89002.0 89044.6 90844.5 1030.8 1042.1 1078.3 1096.3 1102.5 16355.4 16889.9 17070.5 17110.9 17274.2 30281.0 37072.6 37743.4 38619.4 39089.6 50018.2 51054.0 51095.5 51921.5 52548.2 8471.0 8716.1 8772.6 8807.9 8881.0 12775.8 13274.8 13464.7 13550.8 13700.9 11172.2 12109.2 12222.3 12349.7 12365.5 11672.4 11760.7 11770.3 11981.2 12051.5 12143.8 12171.9 12212.5 12331.2 12456.4 7255.6 7641.2 7907.5 7966.1 8589.0 10458.5 10924.1 11131.5 11690.5 11840.8 08:22:49 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | [#3] mootools.html Cycles:180 Average:5415.43 Median:5096.12 stddev:3004.23 (59.0%) stddev-sans-first:2998.20 08:22:49 INFO - PROCESS | 1617 | Values: 1494.1 1522.2 1659.4 1710.5 1792.9 7482.1 8023.5 8065.1 8321.5 8364.4 8006.1 8009.4 8084.3 8095.8 8102.7 2231.6 2244.3 2265.3 2267.9 2273.4 2221.9 2233.9 2241.3 2250.3 2254.6 2265.2 2268.6 2274.5 2291.1 2298.6 2165.6 2166.1 2181.5 2191.6 2198.2 2131.5 2149.0 2154.2 2158.7 2161.8 8238.0 8323.0 8337.0 8338.4 8362.3 4696.6 4837.8 4878.4 4887.6 4926.4 2932.6 3040.3 3085.9 3098.3 3116.8 1000.8 1002.7 1005.9 1039.3 1041.1 11055.2 11070.2 11096.6 11106.5 11133.9 4247.3 4297.5 4399.3 4457.7 4461.3 9422.3 9424.7 9460.2 9472.1 9487.2 4678.3 4717.3 4719.8 4728.8 4747.3 4006.6 4279.6 4375.3 4402.2 4408.3 3824.5 3839.4 3946.4 3976.9 3992.7 1265.9 1299.1 1306.8 1312.8 1321.8 853.3 872.6 919.7 929.0 931.2 5574.8 5597.7 5726.3 5741.8 5780.8 908.2 957.3 965.1 981.3 987.4 3793.1 3822.1 3836.5 3857.8 3862.0 9808.0 10013.7 10096.8 10106.4 10187.2 10116.5 10128.8 10162.5 10175.7 10182.0 7660.1 7665.5 7670.5 7727.3 7876.6 5589.4 5600.7 5601.6 5667.2 5733.6 9141.8 9197.3 9365.5 9381.5 9404.2 9207.7 9314.8 9384.4 9453.0 9484.8 6694.5 6762.2 6904.7 6990.7 7078.6 8092.4 8111.8 8116.8 8154.8 8163.4 7069.5 7291.0 7321.3 7367.6 7446.8 6813.1 6821.1 6838.1 6890.1 6936.5 6429.2 6531.4 6630.5 6673.5 6686.8 5041.6 5068.2 5124.0 5134.1 5141.2 5160.3 5222.9 5243.8 5291.4 5324.1 08:22:49 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | [#4] prototype.html Cycles:180 Average:5246.53 Median:6001.64 stddev:1592.95 (26.5%) stddev-sans-first:1553.77 08:22:49 INFO - PROCESS | 1617 | Values: 312.1 318.8 323.7 329.1 329.4 5816.2 5937.4 5973.1 5973.3 6005.9 5890.8 5948.3 5949.0 5999.9 6003.4 4438.5 4526.3 4540.8 4562.6 4564.7 4402.3 4536.6 4550.6 4557.3 4560.1 4470.5 4473.6 4483.5 4494.7 4496.2 4498.7 4500.4 4505.7 4517.5 4523.3 3840.4 3936.7 3954.9 3958.3 3959.8 5613.8 5689.7 5707.4 5716.2 5760.5 5161.4 5174.0 5177.5 5210.2 5213.4 6036.9 6216.5 6223.8 6240.0 6262.5 4293.1 4328.7 4338.1 4354.3 4354.3 6377.7 6513.4 6540.6 6543.5 6555.4 4436.4 4443.7 4451.4 4475.0 4488.3 4444.2 4444.5 4483.3 4493.8 4529.5 5217.3 5232.6 5235.8 5240.8 5248.1 5988.5 6006.8 6089.3 6225.8 6322.7 1530.6 1549.8 1554.9 1556.2 1559.0 1000.3 1013.7 1020.4 1028.5 1036.7 6115.4 6129.1 6134.8 6145.0 6174.9 6442.5 6456.7 6485.1 6492.2 6509.0 5998.4 6023.3 6081.2 6098.2 6176.9 3451.7 3454.7 3495.9 3498.0 3499.9 6553.8 6708.9 6716.4 6725.0 6763.3 6548.2 6578.9 6582.9 6584.1 6589.2 6595.2 6693.7 6720.2 6755.4 6759.2 6463.3 6465.8 6474.8 6484.2 6514.9 6252.9 6360.2 6402.6 6410.0 6410.8 6692.0 6715.2 6727.4 6751.4 6783.8 4346.7 4353.7 4381.0 4385.2 4391.6 6280.9 6291.7 6485.2 6503.7 6552.1 6253.8 6290.7 6352.9 6384.2 6384.8 6120.0 6272.5 6277.6 6319.0 6330.6 6200.8 6235.6 6237.2 6239.4 6250.3 6360.6 6373.8 6399.6 6423.6 6432.6 5922.9 6157.0 6169.7 6170.1 6282.2 08:22:49 INFO - PROCESS | 1617 | 08:22:49 INFO - PROCESS | 1617 | [#5] yui.html Cycles:180 Average:13647.07 Median:54663.95 stddev:16909.37 (30.9%) stddev-sans-first:16929.14 08:22:49 INFO - PROCESS | 1617 | Values: 766.2 771.1 793.6 794.3 802.7 11959.5 11987.2 12084.3 12140.5 12224.1 11105.0 12074.2 12365.3 12380.3 12387.8 677.1 796.5 824.9 827.8 831.7 818.8 820.0 820.1 821.0 823.2 856.3 858.2 859.5 860.6 861.2 851.0 851.6 855.7 856.9 857.5 620.5 620.6 622.8 625.0 625.9 12326.1 12424.7 12437.9 12445.5 12494.3 10844.8 10928.3 11107.3 11175.6 11214.7 8935.7 8998.1 9020.6 9024.2 9117.2 3184.5 3238.5 3287.8 3292.8 3329.3 60615.4 60775.1 61264.6 61725.0 61847.4 8667.3 8888.6 9014.9 9150.6 9275.9 17085.7 17103.8 17282.0 17334.3 17340.6 6767.2 6826.8 6875.4 7071.4 7185.2 4006.2 4033.5 4075.1 4107.8 4119.3 3030.0 3133.1 3138.2 3141.1 3146.6 559.3 565.4 568.2 575.1 576.0 637.1 654.7 671.5 675.8 677.1 7830.6 8075.2 8205.8 8260.7 8390.5 633.8 663.5 668.2 672.4 679.4 3732.8 3859.7 3915.7 3963.6 3981.8 53735.5 55592.4 67135.0 67247.3 67374.3 45417.3 51446.6 51492.5 52390.5 53657.5 36749.1 39621.0 40249.0 46073.8 48825.3 7900.5 7902.5 8009.5 8208.5 8294.5 29163.6 29715.4 29737.7 34117.9 34349.8 42584.6 42638.8 42684.0 43298.8 43656.8 11114.5 11150.4 11229.3 11360.3 11600.0 10986.3 11197.1 11307.3 11464.5 11569.7 10157.2 10218.6 10291.7 10724.0 10956.2 10649.4 10736.4 10781.1 10919.2 11191.5 10071.5 10358.3 10390.2 10464.0 10498.2 9190.0 9223.4 9282.8 9379.5 9470.5 9459.5 9669.0 9699.8 9700.2 9811.7 08:22:49 INFO - PROCESS | 1617 | -------- Summary: end -------- 08:22:49 INFO - PROCESS | 1617 | 08:22:50 INFO - TEST-INFO | 1617: exit 0 08:22:50 INFO - TEST-OK | dromaeo_css | took 1109965ms 08:22:50 INFO - TEST-START | kraken 08:22:50 INFO - operating with platform_type : linux_ 08:22:50 INFO - Initialising browser for kraken test... 08:22:50 INFO - TEST-INFO | started process 1853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0cjQ9h/profile http://localhost:42422/getInfo.html) 08:22:53 INFO - PROCESS | 1853 | 08:22:53 INFO - PROCESS | 1853 | (process:1920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:22:53 INFO - PROCESS | 1853 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:22:54 INFO - PROCESS | 1853 | __metrics Screen width/height:1600/1200 08:22:54 INFO - PROCESS | 1853 | colorDepth:24 08:22:54 INFO - PROCESS | 1853 | Browser inner width/height: 1024/697 08:22:54 INFO - PROCESS | 1853 | __metrics 08:22:55 ERROR - PROCESS | 1853 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:22:56 INFO - TEST-INFO | 1853: exit 0 08:22:56 INFO - Browser initialized. 08:22:56 INFO - Running cycle 1/1 for kraken test... 08:22:56 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0cjQ9h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:57 INFO - PROCESS | 1971 | 08:22:57 INFO - PROCESS | 1971 | (process:2032): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:23:07 INFO - PROCESS | 1971 | RSS: Main: 163188736 08:23:07 INFO - PROCESS | 1971 | 08:23:10 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42422/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:11 INFO - PROCESS | 1971 | RSS: Main: 167596032 08:23:11 INFO - PROCESS | 1971 | 08:23:14 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42422/tests/kraken/driver.html?testName=audio-dft) 08:23:14 INFO - PROCESS | 1971 | RSS: Main: 170975232 08:23:14 INFO - PROCESS | 1971 | 08:23:17 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42422/tests/kraken/driver.html?testName=audio-fft) 08:23:18 INFO - PROCESS | 1971 | RSS: Main: 161660928 08:23:18 INFO - PROCESS | 1971 | 08:23:20 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42422/tests/kraken/driver.html?testName=audio-oscillator) 08:23:21 INFO - PROCESS | 1971 | RSS: Main: 161652736 08:23:21 INFO - PROCESS | 1971 | 08:23:23 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42422/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:23 INFO - PROCESS | 1971 | RSS: Main: 163201024 08:23:23 INFO - PROCESS | 1971 | 08:23:26 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42422/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:27 INFO - PROCESS | 1971 | RSS: Main: 163266560 08:23:27 INFO - PROCESS | 1971 | 08:23:30 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42422/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:31 INFO - PROCESS | 1971 | RSS: Main: 165523456 08:23:31 INFO - PROCESS | 1971 | 08:23:34 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42422/tests/kraken/driver.html?testName=json-parse-financial) 08:23:35 INFO - PROCESS | 1971 | RSS: Main: 166051840 08:23:35 INFO - PROCESS | 1971 | 08:23:36 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42422/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:37 INFO - PROCESS | 1971 | RSS: Main: 166068224 08:23:37 INFO - PROCESS | 1971 | 08:23:39 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42422/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:39 INFO - PROCESS | 1971 | RSS: Main: 165924864 08:23:39 INFO - PROCESS | 1971 | 08:23:41 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42422/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:42 INFO - PROCESS | 1971 | RSS: Main: 166367232 08:23:42 INFO - PROCESS | 1971 | 08:23:44 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:23:45 INFO - PROCESS | 1971 | RSS: Main: 166567936 08:23:45 INFO - PROCESS | 1971 | 08:23:48 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:23:49 INFO - PROCESS | 1971 | RSS: Main: 166490112 08:23:49 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:42422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42422/tests/kraken/driver.html?testName=ai-astar) 08:23:50 INFO - PROCESS | 1971 | RSS: Main: 167931904 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | __start_tp_report 08:23:50 INFO - PROCESS | 1971 | _x_x_mozilla_page_load 08:23:50 INFO - PROCESS | 1971 | _x_x_mozilla_page_load_details 08:23:50 INFO - PROCESS | 1971 | |i|pagename|runs| 08:23:50 INFO - PROCESS | 1971 | |0;ai-astar;111;106;111;114;111;125;112;111;111;111 08:23:50 INFO - PROCESS | 1971 | |1;audio-beat-detection;168;136;165;185;134;153;153;130;179;129 08:23:50 INFO - PROCESS | 1971 | |2;audio-dft;163;164;163;163;165;165;167;162;165;163 08:23:50 INFO - PROCESS | 1971 | |3;audio-fft;76;76;74;161;78;72;76;74;151;79 08:23:50 INFO - PROCESS | 1971 | |4;audio-oscillator;93;93;140;93;93;93;136;94;94;154 08:23:50 INFO - PROCESS | 1971 | |5;imaging-gaussian-blur;119;117;117;117;118;117;117;117;117;118 08:23:50 INFO - PROCESS | 1971 | |6;imaging-darkroom;146;148;148;147;147;147;149;145;147;146 08:23:50 INFO - PROCESS | 1971 | |7;imaging-desaturate;95;96;100;96;96;95;95;95;95;95 08:23:50 INFO - PROCESS | 1971 | |8;json-parse-financial;58;62;62;59;60;59;59;79;58;57 08:23:50 INFO - PROCESS | 1971 | |9;json-stringify-tinderbox;61;60;61;61;61;63;61;63;61;61 08:23:50 INFO - PROCESS | 1971 | |10;stanford-crypto-aes;77;76;74;85;77;77;78;77;77;77 08:23:50 INFO - PROCESS | 1971 | |11;stanford-crypto-ccm;129;129;127;126;130;134;127;128;168;140 08:23:50 INFO - PROCESS | 1971 | |12;stanford-crypto-pbkdf2;168;170;165;165;174;165;172;164;166;162 08:23:50 INFO - PROCESS | 1971 | |13;stanford-crypto-sha256-iterative;72;71;73;69;68;72;68;67;70;67 08:23:50 INFO - PROCESS | 1971 | __end_tp_report 08:23:50 INFO - PROCESS | 1971 | __start_cc_report 08:23:50 INFO - PROCESS | 1971 | _x_x_mozilla_cycle_collect,824 08:23:50 INFO - PROCESS | 1971 | __end_cc_report 08:23:50 INFO - PROCESS | 1971 | __startTimestamp1460906630975__endTimestamp 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | ------- Summary: start ------- 08:23:50 INFO - PROCESS | 1971 | Number of tests: 14 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.00 stddev:4.88 (4.4%) stddev-sans-first:5.15 08:23:50 INFO - PROCESS | 1971 | Values: 111.0 106.0 111.0 114.0 111.0 125.0 112.0 111.0 111.0 111.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:159.00 stddev:20.61 (13.0%) stddev-sans-first:21.15 08:23:50 INFO - PROCESS | 1971 | Values: 168.0 136.0 165.0 185.0 134.0 153.0 153.0 130.0 179.0 129.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:1.49 (0.9%) stddev-sans-first:1.54 08:23:50 INFO - PROCESS | 1971 | Values: 163.0 164.0 163.0 163.0 165.0 165.0 167.0 162.0 165.0 163.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#3] audio-fft Cycles:10 Average:91.70 Median:76.00 stddev:34.03 (44.8%) stddev-sans-first:35.62 08:23:50 INFO - PROCESS | 1971 | Values: 76.0 76.0 74.0 161.0 78.0 72.0 76.0 74.0 151.0 79.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.59 (26.4%) stddev-sans-first:25.45 08:23:50 INFO - PROCESS | 1971 | Values: 93.0 93.0 140.0 93.0 93.0 93.0 136.0 94.0 94.0 154.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.44 08:23:50 INFO - PROCESS | 1971 | Values: 119.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 08:23:50 INFO - PROCESS | 1971 | Values: 146.0 148.0 148.0 147.0 147.0 147.0 149.0 145.0 147.0 146.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 08:23:50 INFO - PROCESS | 1971 | Values: 95.0 96.0 100.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:59.50 stddev:6.43 (10.8%) stddev-sans-first:6.71 08:23:50 INFO - PROCESS | 1971 | Values: 58.0 62.0 62.0 59.0 60.0 59.0 59.0 79.0 58.0 57.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.95 (1.6%) stddev-sans-first:1.00 08:23:50 INFO - PROCESS | 1971 | Values: 61.0 60.0 61.0 61.0 61.0 63.0 61.0 63.0 61.0 61.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:2.84 (3.7%) stddev-sans-first:3.00 08:23:50 INFO - PROCESS | 1971 | Values: 77.0 76.0 74.0 85.0 77.0 77.0 78.0 77.0 77.0 77.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:129.50 stddev:12.72 (9.8%) stddev-sans-first:13.37 08:23:50 INFO - PROCESS | 1971 | Values: 129.0 129.0 127.0 126.0 130.0 134.0 127.0 128.0 168.0 140.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.00 stddev:3.81 (2.3%) stddev-sans-first:4.03 08:23:50 INFO - PROCESS | 1971 | Values: 168.0 170.0 165.0 165.0 174.0 165.0 172.0 164.0 166.0 162.0 08:23:50 INFO - PROCESS | 1971 | 08:23:50 INFO - PROCESS | 1971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.50 stddev:2.21 (3.1%) stddev-sans-first:2.19 08:23:50 INFO - PROCESS | 1971 | Values: 72.0 71.0 73.0 69.0 68.0 72.0 68.0 67.0 70.0 67.0 08:23:50 INFO - PROCESS | 1971 | -------- Summary: end -------- 08:23:50 INFO - PROCESS | 1971 | 08:23:51 INFO - TEST-INFO | 1971: exit 0 08:23:51 INFO - TEST-OK | kraken | took 61772ms 08:23:51 INFO - SUITE-END | took 1171s 08:23:52 INFO - Completed test suite (00:19:31) 08:23:52 INFO - javascript benchmark 08:23:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.218879185808, 3131.311111555457, 3135.482645363515, 3170.9524357134633, 3172.397244523539, 5350.946490535093, 5382.91925621116, 5396.865078373043, 5398.811041613544, 5403.6487628304185, 5277.973610131944, 5392.110301800208, 5443.101888188454, 5568.0, 5592.720363981794, 4856.465788763233, 4885.682430642015, 4931.457539670633, 4960.87597810054, 5002.424721157077, 4864.878378040559, 4925.630577706668, 4971.0, 4985.775640096186, 5049.267856160873, 4816.903661926759, 4852.393450818648, 4868.805247790084, 4893.412790465131, 4939.876503087434, 4842.297866809293, 4859.73271470069, 4868.269759536062, 4874.683145595561, 4891.804327826882, 4816.759162041884, 4838.371011768448, 4843.0, 4860.489648586883, 4865.537773911473, 5128.769205385729, 5264.578833693296, 5323.414424413311, 5333.439988801198, 5376.4085950545405, 5788.9290481261105, 5800.709964501758, 5812.651240925558, 5844.941550584483, 5880.941190588125, 5754.769809207627, 5795.362510123883, 5885.4997325227405, 5889.558283128739, 5890.617109887844, 5359.598030147755, 5410.594205434569, 5415.431379705153, 5427.3215848019, 5467.316585426822, 5918.171455996164, 5926.436988486087, 5973.522118230531, 5983.940160598426, 5984.640921544721, 5522.144067669517, 5639.210510528529, 5702.344230413472, 5744.195812586241, 5744.971275143597, 5741.885162296814, 5841.795537156264, 5849.883002340014, 5853.853653658693, 5901.114832775118, 5611.831645050655, 5680.886382272414, 5790.536757059425, 5797.449242321973, 5865.6480611162615, 5645.491905728504, 5761.452661997104, 5817.360090390053, 5819.098039803837, 5857.648541087548, 4264.04059086703, 4271.402003719481, 4328.199283132568, 4402.405675233803, 4443.37792709021, 3892.4550562921213, 3913.2369188008634, 3915.158240978203, 3925.8961014430283, 3959.5842436544326, 5514.476124768141, 5545.528630066409, 5566.666000040011, 5602.467765562265, 5623.184638227516, 5728.341240757366, 5797.913031304533, 5819.592628516048, 5873.0, 5907.763689452374, 5639.464250896241, 5663.716814159276, 5668.461496157858, 5671.914921276184, 5673.914891276634, 4772.546608072227, 4992.101421744121, 4992.525710057539, 5002.099622068063, 5018.04657115147, 5950.2264705587995, 6070.575059745775, 6102.883130681719, 6107.12812945598, 6124.724387402489, 5724.341700704473, 5755.8273251801675, 5762.769489220552, 5789.8263052108505, 5792.884142317046, 5881.441263080001, 5888.735006924613, 5971.7611295547695, 5982.312034116132, 5993.460588547052, 5673.319201695823, 5686.203931449683, 5692.971535142297, 5696.344920334214, 5749.453801888814, 5652.236948011966, 5772.1341798728845, 5779.711014449176, 5788.623739456922, 5790.305163380252, 5516.3380394352935, 5561.499465048165, 5572.3034620672415, 5596.440355964371, 5605.635633683961, 5583.497485226349, 5612.522935550524, 5617.88764224705, 5645.745941432728, 5649.237352957298, 5582.469665381782, 5597.44025597437, 5609.663420194802, 5609.747561359667, 5626.803061892814, 5568.888622227451, 5674.914876276776, 5698.572607054571, 5729.427057294237, 5793.91309130355, 5529.612927095065, 5598.0, 5614.2701448811395, 5627.662340259598, 5637.351704553865], "value": 5333.231049706061, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.6055803169909, 649.3474058571136, 658.5456035335618, 671.0873212431094, 689.4725534965755, 31999.160100787907, 32764.0, 33280.0, 34032.31935361295, 34537.0, 37978.8101059495, 38148.61851381485, 38584.80707596465, 38632.613673863256, 38670.419943700865, 8333.125021872722, 8464.32285417165, 8467.407281490297, 8498.660053597849, 8507.234348908598, 8246.958765206165, 8566.914330856674, 8567.057623661392, 8625.827483450326, 8653.307735381155, 8631.395802293842, 8647.221750042494, 8722.12778722129, 8727.301815854747, 8730.301575873915, 8597.828043439127, 8629.482231066157, 8633.438826476291, 8658.740237792876, 8666.0, 8516.23353898146, 8570.914290857074, 8648.783780405478, 8653.783655408664, 8716.956415217883, 32318.19204519906, 35029.47455788165, 35431.645683543094, 36130.45804312911, 36198.81900590507, 3102.177922850424, 3117.2206948262933, 3314.5028245763087, 3739.439084137401, 3818.274527839729, 30152.54771178434, 30655.846720766476, 30887.0, 31049.0, 31535.0, 4165.520965089023, 4172.395002724618, 4217.8312867485265, 4262.46719160105, 4297.140571885635, 293573.0, 295498.0, 299303.0, 299792.0, 301717.0, 36682.44976325357, 62154.0, 62265.377346226865, 62823.68588157121, 62955.37044629495, 36679.0, 36905.630943690754, 36953.630463695554, 36984.63015369866, 37118.44322335167, 14017.579472615838, 14019.158850469004, 14075.577732668036, 14079.577612671636, 14169.504067357593, 11268.267562608404, 11350.318980861175, 11395.088392928712, 11418.0, 11441.0, 8594.312455003585, 8778.341624378198, 8818.0, 8831.64673413069, 8847.557622118868, 3146.8269245191277, 3182.299894023311, 3191.6010498687665, 3227.951580726291, 3242.5460435539044, 1094.529352378469, 1132.1395739238237, 1150.4995327032768, 1177.9823302650468, 1184.0350114656528, 31912.202194945312, 32092.518612220836, 32171.51742723861, 32283.677163228538, 32972.3405531888, 1089.9945500272447, 1112.5382966069153, 1129.282905355089, 1136.1882427917762, 1183.2308999150448, 14951.102933824006, 15014.699706005818, 15173.620659483602, 15637.921810390875, 15757.921210394104, 205996.0, 206627.0, 207191.0, 207712.0, 207915.0, 55325.0, 55864.0, 56285.437145628835, 56568.43431565714, 57116.0, 1328.110166188656, 1372.1766939836018, 1373.9450421983208, 1378.0491460891953, 1477.8743806776329, 29085.85457072701, 29357.0, 29500.704992949795, 29954.70045299606, 30734.538981915735, 46245.53754462547, 46272.30591541062, 46297.537024629324, 46823.76588117037, 46997.0, 405111.0, 406602.0, 408149.0, 408376.0, 409872.0, 28208.0, 28747.425051498434, 28763.85618071896, 28779.424411511234, 37082.25835483329, 41422.1715565681, 41563.0, 41679.374809377274, 41701.1659766809, 43124.0, 37954.81022594869, 38747.806260968515, 38804.6119538801, 38826.80586597162, 38900.80549597234, 37557.4366384499, 39097.41353879637, 41316.0, 41933.58066419297, 42619.0, 39992.2001559973, 40564.0, 42159.578404216794, 43202.567974319856, 43484.78257608692, 33025.0, 34440.48339274963, 34539.48190777191, 34612.9616111517, 35108.824455877555, 27010.72989270082, 27574.172774816787, 27918.0, 28040.158795236177, 28580.714192857806], "value": 17675.89561683083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.3641491538962, 395.28650785332474, 400.17963175490246, 400.44138426894466, 407.75534679192486, 14072.577822665311, 17493.300267989263, 18303.0, 18389.816101838995, 18589.44231673052, 18106.909465452653, 18303.816961830376, 18621.44135675932, 18986.810131898677, 19087.0, 5501.504864562188, 5559.833205003846, 5713.685747283897, 5735.283089613798, 5749.56878234132, 5704.286964129484, 5710.029295019856, 5716.428357164271, 5729.0833466645345, 5743.3108027036815, 5495.835124946258, 5683.431656834304, 5686.260786097801, 5689.0, 5720.513756330696, 5466.8359949201185, 5675.914861277063, 5678.43215678433, 5683.204351390808, 5700.37295897451, 5066.645334826564, 5099.311592934943, 5101.0, 5101.387833459971, 5101.795928162869, 20649.58700825975, 20721.27475538349, 20803.0, 20922.686159707617, 21786.34640960758, 2029.4926268432891, 2183.257692384597, 2214.944626384337, 2306.7923886850263, 2638.1162310625964, 9334.0, 9749.07383798538, 10192.388456692548, 11265.26775759573, 13611.591652250449, 1839.8620103492292, 1888.6317168152216, 1908.4656296237076, 1938.6898096304524, 1939.8933058681766, 67723.66138169277, 69015.3098469014, 69640.30359696389, 70061.2993870065, 71383.0, 9863.605455781832, 10145.08694217524, 10213.33613315147, 10301.74245643865, 10415.739606509898, 13174.802377964339, 13822.516211932534, 13844.861551384558, 13969.231692257023, 14029.85970140306, 7465.7013719450615, 7624.847503049908, 7669.156392796788, 7686.270589117516, 7927.643256053491, 7216.7474138404905, 7318.890216646648, 7330.523515971445, 7384.815379615553, 7467.066616672916, 4399.12017596482, 4440.866773996785, 4479.328100784843, 4498.785327961497, 4509.842155524541, 1818.7999320074782, 1837.9356722514647, 1901.657701613695, 1926.5568919148675, 1934.4003358958769, 995.3082607587658, 1036.6164519127972, 1132.5356603792407, 1162.3665102518978, 1186.8397766301612, 18409.447716568524, 18792.342268020555, 18976.620467590572, 19388.515287117934, 19577.510562235773, 1008.2690049713899, 1034.5034383495813, 1070.9946450267855, 1108.1356541897333, 1109.8723646780722, 10493.160547156209, 10995.230333876712, 11006.504707288192, 11065.889341106647, 11145.944270278758, 466624.0, 467895.0, 470119.0, 471182.0, 488979.0, 82495.58752206201, 84622.0, 89002.0, 89044.5547772257, 90844.54577727069, 1030.8041472120274, 1042.0777611813448, 1078.2883297023927, 1096.331237944853, 1102.4653043274006, 16355.427560035341, 16889.915550422662, 17070.48788536346, 17110.914445427694, 17274.222659980078, 30281.0, 37072.629273706916, 37743.433848491746, 38619.42070868883, 39089.609103908595, 50018.249726254864, 51054.0, 51095.489045109076, 51921.48078519166, 52548.211776824144, 8471.0, 8716.084811094745, 8772.605232764414, 8807.91192088071, 8880.978687450768, 12775.808362874379, 13274.800877986645, 13464.663383415493, 13550.796738049134, 13700.93149534246, 11172.217944744116, 12109.212901161396, 12222.327771972627, 12349.69125771827, 12365.505379785067, 11672.358020308964, 11760.705982350168, 11770.293782373084, 11981.221220620631, 12051.51793928233, 12143.817842732542, 12171.878281217074, 12212.450439730055, 12331.198472099284, 12456.439460224494, 7255.56466612005, 7641.235876412315, 7907.525548467111, 7966.083900351302, 8589.0, 10458.47707614601, 10924.12606991423, 11131.499082541468, 11690.4739286734, 11840.76318473643], "value": 8959.056313244022, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.0512774388267, 1522.2160587297544, 1659.3777333499938, 1710.5296043588019, 1792.8834625749334, 7482.102147742278, 8023.478473899199, 8065.072516660586, 8321.542315172663, 8364.372672049598, 8006.1193268740535, 8009.439339246255, 8084.2724154826055, 8095.757127286191, 8102.675892964275, 2231.6317807561772, 2244.3267019894047, 2265.3317271404976, 2267.9319620411416, 2273.374821923976, 2221.911123555056, 2233.8883055847223, 2241.2827895073583, 2250.324902529243, 2254.6392577187653, 2265.1732117777055, 2268.625676763332, 2274.4882401459704, 2291.0835665733757, 2298.586254474194, 2165.621016322153, 2166.068590506082, 2181.4764456530397, 2191.6493361062235, 2198.1537108213292, 2131.467133216696, 2149.0, 2154.2352464875057, 2158.665406861939, 2161.8054375106317, 8238.0, 8322.958385208096, 8337.0, 8338.374621903382, 8362.331013518904, 4696.647751418657, 4837.8306759263605, 4878.390201224847, 4887.584555312803, 4926.4088309403105, 2932.618759561243, 3040.300730831899, 3085.8765649374, 3098.2719061020643, 3116.766242531819, 1000.8448690452918, 1002.6540843409012, 1005.8843233028149, 1039.3192458939332, 1041.0994489766374, 11055.22613417061, 11070.225084244106, 11096.55613775448, 11106.500207490682, 11133.944330278297, 4247.256730072225, 4297.484301883794, 4399.318105693623, 4457.732536047847, 4461.263891457938, 9422.34043616954, 9424.670136545188, 9460.243180545678, 9472.05279472061, 9487.193588545051, 4678.2982552616695, 4717.268823332389, 4719.834805781781, 4728.787204575802, 4747.2879068140055, 4006.639402453793, 4279.614834664895, 4375.299952007664, 4402.185595664812, 4408.316710909814, 3824.521934758155, 3839.3856982883162, 3946.408038794204, 3976.8608098716986, 3992.720509564361, 1265.8670839561898, 1299.0711641176604, 1306.8105124756858, 1312.8030795380769, 1321.7951217561294, 853.2789792625346, 872.5549969515466, 919.72868003939, 928.967486137982, 931.2224292715658, 5574.804881829197, 5597.6641401516035, 5726.341470730919, 5741.770329186869, 5780.814932938738, 908.1826356279402, 957.3394357893031, 965.0976337124811, 981.2787601113176, 987.4470296633908, 3793.0896584819443, 3822.140018495872, 3836.501254836909, 3857.8263978121054, 3862.0, 9808.0, 10013.749656258651, 10096.848547271797, 10106.39361638304, 10187.235957303084, 10116.54475548602, 10128.848067278997, 10162.4918754062, 10175.745606359753, 10182.0, 7660.080790305199, 7665.540067595962, 7670.501417407962, 7727.265909738566, 7876.645550950221, 5589.413111623221, 5600.663960162403, 5601.6358936668985, 5667.20659107717, 5733.598648094593, 9141.817163656557, 9197.310201734763, 9365.531723413666, 9381.530923453936, 9404.247660187031, 9207.723768286962, 9314.778897403787, 9384.436933783994, 9453.0, 9484.810303794024, 6694.4644428444635, 6762.188537375547, 6904.689288982108, 6990.685419156252, 7078.575285482888, 8092.393070519617, 8111.75664730059, 8116.75649730509, 8154.796130096795, 8163.387745919199, 7069.505134640526, 7290.963545182452, 7321.341079302888, 7367.63161841895, 7446.813829654302, 6813.148356455443, 6821.147356580427, 6838.076859623887, 6890.069840571458, 6936.543325901617, 6429.196350456193, 6531.379518945692, 6630.469562434897, 6673.499487538357, 6686.765963191265, 5041.571466425395, 5068.239764035424, 5124.0, 5134.12719837621, 5141.2288156776785, 5160.251763494197, 5222.869428264172, 5243.764030618708, 5291.417944026077, 5324.094903866429], "value": 4379.212816696643, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.08870099310025, 318.80393557961855, 323.7248338911924, 329.1113992221004, 329.4152878640413, 5816.185733997244, 5937.435943585363, 5973.133895585143, 5973.283206015273, 6005.9189345917775, 5890.764369425217, 5948.31594366648, 5948.970255148729, 5999.910001349972, 6003.369646187153, 4438.511763705989, 4526.343680166374, 4540.79566419512, 4562.634989200873, 4564.703294285878, 4402.3176407656865, 4536.637069034469, 4550.613197878184, 4557.339185818055, 4560.110778398213, 4470.485894122169, 4473.575010374009, 4483.461984561857, 4494.719005083552, 4496.235639941217, 4498.740352701233, 4500.437445319335, 4505.684602077856, 4517.5215084385, 4523.298888672228, 3840.385538313856, 3936.665383442411, 3954.940675889864, 3958.34687276599, 3959.821808018617, 5613.831585052455, 5689.743961521742, 5707.4031315751645, 5716.228309178291, 5760.481556659879, 5161.3806343238675, 5174.0, 5177.498525427659, 5210.218467229908, 5213.4004589472315, 6036.879262414727, 6216.533759968021, 6223.813285601439, 6240.0, 6262.499000079983, 4293.141371725667, 4328.740275583444, 4338.110687309094, 4354.259775838115, 4354.259775838115, 6377.681115944184, 6513.446357059655, 6540.607563546155, 6543.5461701861805, 6555.3772391622715, 4436.3567282743825, 4443.7111587746695, 4451.399061126771, 4474.977625111854, 4488.326750987378, 4444.177827101997, 4444.511103778582, 4483.2826747720865, 4493.7977790999485, 4529.4599836055895, 5217.321748172713, 5232.633715639945, 5235.764390602432, 5240.842774716764, 5248.134057880483, 5988.526654540443, 6006.789762358384, 6089.330173680892, 6225.8132256032395, 6322.683865806691, 1530.6096945279105, 1549.7520396736468, 1554.875609951201, 1556.2452210677811, 1558.9532314030598, 1000.3197825478744, 1013.6958912326272, 1020.3826684855555, 1028.5320179318392, 1036.7149034015706, 6115.379424452523, 6129.08063790435, 6134.754609815557, 6144.988955411816, 6174.876502470015, 6442.549021568445, 6456.709448074848, 6485.092087107809, 6492.156019717407, 6508.967455162694, 5998.430149135826, 6023.3073196582955, 6081.239845019372, 6098.176746139215, 6176.8764624707255, 3451.6548345165784, 3454.7236221102253, 3495.8951231463097, 3498.0, 3499.9125021874656, 6553.803385898431, 6708.899366509506, 6716.361945615159, 6725.024871393621, 6763.2898545652, 6548.246951600627, 6578.868422631521, 6582.901256481156, 6584.078229047937, 6589.242237142694, 6595.175603049619, 6693.698783554752, 6720.1599800025, 6755.392014718601, 6759.188897332351, 6463.25672547663, 6465.77369792055, 6474.805755827333, 6484.1894763154605, 6514.9348506514325, 6252.905741495311, 6360.236771587254, 6402.5518213726455, 6410.0, 6410.839729006812, 6692.0, 6715.160604924385, 6727.394534491919, 6751.358620931003, 6783.762568310085, 4346.65226781863, 4353.673474489363, 4380.9780951095045, 4385.232584297799, 4391.64866810648, 6280.874382512416, 6291.748330066929, 6485.156929599122, 6503.707333169924, 6552.1154644124335, 6253.812385628438, 6290.748370065146, 6352.9047064293145, 6384.201974753156, 6384.840378990562, 6119.969400152971, 6272.4982001440685, 6277.591956522811, 6318.968405158129, 6330.620162790247, 6200.844978875564, 6235.594686345373, 6237.157983672146, 6239.407256310643, 6250.281217660027, 6360.554761166674, 6373.840653983688, 6399.55203135776, 6423.646699431576, 6432.614043157426, 5922.851928701817, 6157.0, 6169.660668663267, 6170.10533472653, 6282.1519094921605], "value": 4720.319790260994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2337662337666, 771.1478815908421, 793.6428607126794, 794.301015106706, 802.6909639788681, 11959.521619135236, 11987.220830646002, 12084.274943503386, 12140.453679584418, 12224.083193760482, 11105.0, 12074.215176013575, 12365.319907405112, 12380.319082450462, 12387.752244955096, 677.1366507702669, 796.4623878881761, 824.8638974569188, 827.8302947895697, 831.7047448155909, 818.8075802186481, 820.0159808230118, 820.1388542030844, 820.9630566624486, 823.2467292427422, 856.2764464027887, 858.171864151094, 859.4542465534399, 860.6127242740761, 861.1775754154767, 850.9574521273912, 851.5742128935532, 855.683397143058, 856.9400141990094, 857.536930057768, 620.534599050712, 620.5935112501319, 622.8349487385847, 624.9750009999594, 625.9092431597438, 12326.137170398075, 12424.689382765504, 12437.875621243762, 12445.502179912794, 12494.250344979331, 10844.783104337948, 10928.344299342065, 11107.278026928305, 11175.553973524698, 11214.719632009264, 8935.731928042169, 8998.14517620825, 9020.639174433014, 9024.23294020009, 9117.22503587196, 3184.45864203086, 3238.4656531672244, 3287.8027318360737, 3292.7530435217454, 3329.250918543333, 60615.393846061415, 60775.088373673985, 61264.567220441655, 61725.0, 61847.38152618461, 8667.349948753868, 8888.60001299943, 9014.86477702835, 9150.63397464094, 9275.860862087075, 17085.65828683444, 17103.828961710224, 17282.04948727807, 17334.306627735, 17340.566485837702, 6767.221769496472, 6826.795196144124, 6875.449964002868, 7071.398931090812, 7185.209626941137, 4006.1787333597126, 4033.4779666414693, 4075.062735570776, 4107.835686572504, 4119.279126152911, 3029.9545506817417, 3133.091403493007, 3138.2468207630004, 3141.104785136225, 3146.6381366142728, 559.3288054334814, 565.3780841074868, 568.2101878389043, 575.1085816983658, 575.9798407055733, 637.0635166305616, 654.6759005530348, 671.4896678524259, 675.783749200261, 677.1332694151494, 7830.569318687527, 8075.152109028468, 8205.83588328242, 8260.669573217125, 8390.454620449651, 633.8415396150963, 663.4824836627438, 668.1814776898261, 672.4418732452053, 679.3647939176885, 3732.8320225589914, 3859.729818912649, 3915.7063220258024, 3963.6432721055244, 3981.7610943343493, 53735.462645373045, 55592.444075559535, 67135.0, 67247.32752672509, 67374.32625673778, 45417.31874021892, 51446.59810719895, 51492.48507514877, 52390.47609523932, 53657.463425366026, 36749.08127296786, 39621.0, 40249.0, 46073.7696311523, 48825.26762098642, 7900.486468379537, 7902.4863383879865, 8009.479383840032, 8208.542976156725, 8294.502329860228, 29163.562546561396, 29715.405691886474, 29737.702622973495, 34117.905851298005, 34349.82825085858, 42584.57415425806, 42638.786806067015, 42684.0, 43298.78350608227, 43656.78171609122, 11114.49984750672, 11150.386728729673, 11229.3262404256, 11360.261582997078, 11600.0, 10986.285891417032, 11197.104231661611, 11307.321560706385, 11464.541418343506, 11569.6529104127, 10157.238207134642, 10218.591256349662, 10291.742706432398, 10724.0, 10956.178286628694, 10649.414282214553, 10736.409497477402, 10781.137508999105, 10919.181061420266, 11191.496382662637, 10071.546780395047, 10358.326708763907, 10390.22073344487, 10464.0, 10498.160147188053, 9190.0, 9223.354365194373, 9282.814343712953, 9379.484128372733, 9470.479123648265, 9459.479728614991, 9668.993020937189, 9699.806003879741, 9700.223982081558, 9811.656592019244], "value": 6095.303523860807, "unit": "score"}], "name": "dromaeo_css", "value": 6883.97384963964, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 114.0, 111.0, 125.0, 112.0, 111.0, 111.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 136.0, 165.0, 185.0, 134.0, 153.0, 153.0, 130.0, 179.0, 129.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 165.0, 165.0, 167.0, 162.0, 165.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 161.0, 78.0, 72.0, 76.0, 74.0, 151.0, 79.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 140.0, 93.0, 93.0, 93.0, 136.0, 94.0, 94.0, 154.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 149.0, 145.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 100.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 62.0, 59.0, 60.0, 59.0, 59.0, 79.0, 58.0, 57.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 63.0, 61.0, 63.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 85.0, 77.0, 77.0, 78.0, 77.0, 77.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 127.0, 126.0, 130.0, 134.0, 127.0, 128.0, 168.0, 140.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 165.0, 165.0, 174.0, 165.0, 172.0, 164.0, 166.0, 162.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 69.0, 68.0, 72.0, 68.0, 67.0, 70.0, 67.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1560.3999999999999, "alertThreshold": 2.0}]} 08:23:52 INFO - Return code: 0 08:23:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:23:52 ERROR - # TBPL SUCCESS # 08:23:52 INFO - Running post-action listener: _resource_record_post_action 08:23:52 INFO - Running post-run listener: _resource_record_post_run 08:23:53 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535703552; Read time: 12; Write time: 582760 08:23:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248176640; Read time: 0; Write time: 316988 08:23:53 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283430912; Read time: 12; Write time: 265404 08:23:53 INFO - Running post-run listener: _upload_blobber_files 08:23:53 INFO - Blob upload gear active. 08:23:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:23:53 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 08:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:23:53 INFO - (blobuploader) - INFO - Open directory for files ... 08:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:54 INFO - (blobuploader) - INFO - Done attempting. 08:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:55 INFO - (blobuploader) - INFO - Done attempting. 08:23:55 INFO - (blobuploader) - INFO - Iteration through files over. 08:23:55 INFO - Return code: 0 08:23:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:23:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:23:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21e08b85689d1e5ba41947d14e1189f4315aa00f09c3dcf66f44e1ca1e78198ff0676aa5842ea5cbd72e585989d4ce7bc569119e9f34fb872d9e6ee5c118a8b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40eff1776ebcb69cafb3dacd1edf570c5cc14b611a1f8012ff991cf7931baac48588c8d6fa815d44b6323d6ff742fade79c2855d48b5f9cd26fadbda71ec7714"} 08:23:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:23:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:23:55 INFO - Contents: 08:23:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21e08b85689d1e5ba41947d14e1189f4315aa00f09c3dcf66f44e1ca1e78198ff0676aa5842ea5cbd72e585989d4ce7bc569119e9f34fb872d9e6ee5c118a8b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40eff1776ebcb69cafb3dacd1edf570c5cc14b611a1f8012ff991cf7931baac48588c8d6fa815d44b6323d6ff742fade79c2855d48b5f9cd26fadbda71ec7714"} 08:23:55 INFO - Running post-run listener: copy_logs_to_upload_dir 08:23:55 INFO - Copying logs to upload dir... 08:23:55 INFO - mkdir: /builds/slave/test/build/upload/logs 08:23:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.026623 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-17 08:23:55.214110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 08:23:55.217575) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21e08b85689d1e5ba41947d14e1189f4315aa00f09c3dcf66f44e1ca1e78198ff0676aa5842ea5cbd72e585989d4ce7bc569119e9f34fb872d9e6ee5c118a8b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40eff1776ebcb69cafb3dacd1edf570c5cc14b611a1f8012ff991cf7931baac48588c8d6fa815d44b6323d6ff742fade79c2855d48b5f9cd26fadbda71ec7714"} build_url:https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/NqFK59w-T5ys8BvqNmVaNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21e08b85689d1e5ba41947d14e1189f4315aa00f09c3dcf66f44e1ca1e78198ff0676aa5842ea5cbd72e585989d4ce7bc569119e9f34fb872d9e6ee5c118a8b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40eff1776ebcb69cafb3dacd1edf570c5cc14b611a1f8012ff991cf7931baac48588c8d6fa815d44b6323d6ff742fade79c2855d48b5f9cd26fadbda71ec7714"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 08:23:55.247312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 08:23:55.247743) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1460903243.14596-1794523042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 08:23:55.329097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 08:23:55.329426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 08:23:55.329799) ========= ========= Total master_lag: 0.19 =========