builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1467170414.94 results: success (0) buildid: 20160628192830 builduid: b0763ebf714e434e987f30804fa9b1ce revision: 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.944348) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.944789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.945075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.034612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.034901) ========= 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=4300f881736b422476174874000001bc-1467169601.771539-1207476424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 20:20:15-- 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% 47.0M=0s 2016-06-28 20:20:15 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070337 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.134211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.137558) ========= 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=4300f881736b422476174874000001bc-1467169601.771539-1207476424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017436 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.193074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.196437) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb --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=4300f881736b422476174874000001bc-1467169601.771539-1207476424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 20:20:15,469 truncating revision to first 12 chars 2016-06-28 20:20:15,469 Setting DEBUG logging. 2016-06-28 20:20:15,469 attempt 1/10 2016-06-28 20:20:15,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5af9bddf1fd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 20:20:15,781 unpacking tar archive at: autoland-5af9bddf1fd3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.687117 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.918000) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.918522) ========= script_repo_revision: 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.919282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.919761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.939734) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-28 20:20:15.940005) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1467169601.771539-1207476424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:20:16 INFO - MultiFileLogger online at 20160628 20:20:16 in /builds/slave/test 20:20:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 20:20:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:20:16 INFO - {'append_to_log': False, 20:20:16 INFO - 'base_work_dir': '/builds/slave/test', 20:20:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:20:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:20:16 INFO - 'branch': 'Autoland-Non-PGO', 20:20:16 INFO - 'buildbot_json_path': 'buildprops.json', 20:20:16 INFO - 'config_files': ('talos/linux_config.py',), 20:20:16 INFO - 'default_actions': ('clobber', 20:20:16 INFO - 'read-buildbot-config', 20:20:16 INFO - 'download-and-extract', 20:20:16 INFO - 'populate-webroot', 20:20:16 INFO - 'create-virtualenv', 20:20:16 INFO - 'install', 20:20:16 INFO - 'run-tests'), 20:20:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:20:16 INFO - 'download_minidump_stackwalk': True, 20:20:16 INFO - 'download_symbols': 'ondemand', 20:20:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:20:16 INFO - 'tooltool.py': '/tools/tooltool.py', 20:20:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:20:16 INFO - '/tools/misc-python/virtualenv.py')}, 20:20:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:20:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:20:16 INFO - 'installer_path': 'installer.exe', 20:20:16 INFO - 'log_level': 'info', 20:20:16 INFO - 'log_name': 'talos', 20:20:16 INFO - 'log_to_console': True, 20:20:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:20:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:20:16 INFO - 'opt_config_files': (), 20:20:16 INFO - 'pip_index': False, 20:20:16 INFO - 'sps_profile': False, 20:20:16 INFO - 'sps_profile_interval': 0, 20:20:16 INFO - 'suite': 'dromaeojs-e10s', 20:20:16 INFO - 'system_bits': '32', 20:20:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:20:16 INFO - 'title': 'talos-linux64-ix-045', 20:20:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:20:16 INFO - 'use_talos_json': True, 20:20:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:20:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:20:16 INFO - 'work_dir': 'build'} 20:20:16 INFO - ##### 20:20:16 INFO - ##### Running clobber step. 20:20:16 INFO - ##### 20:20:16 INFO - Running pre-action listener: _resource_record_pre_action 20:20:16 INFO - Running main action method: clobber 20:20:16 INFO - rmtree: /builds/slave/test/build 20:20:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:20:17 INFO - Running post-action listener: _resource_record_post_action 20:20:17 INFO - ##### 20:20:17 INFO - ##### Finished clobber step (success) 20:20:17 INFO - ##### 20:20:17 INFO - ##### 20:20:17 INFO - ##### Running read-buildbot-config step. 20:20:17 INFO - ##### 20:20:17 INFO - Running pre-action listener: _resource_record_pre_action 20:20:17 INFO - Running main action method: read_buildbot_config 20:20:17 INFO - Using buildbot properties: 20:20:17 INFO - { 20:20:17 INFO - "project": "", 20:20:17 INFO - "product": "firefox", 20:20:17 INFO - "script_repo_revision": "production", 20:20:17 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 20:20:17 INFO - "repository": "", 20:20:17 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 20:20:17 INFO - "buildid": "20160628192830", 20:20:17 INFO - "pgo_build": "False", 20:20:17 INFO - "basedir": "/builds/slave/test", 20:20:17 INFO - "buildnumber": 10, 20:20:17 INFO - "slavename": "talos-linux64-ix-045", 20:20:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:20:17 INFO - "platform": "ubuntu64_hw", 20:20:17 INFO - "scheduler": "tests-autoland-linux64-talos", 20:20:17 INFO - "branch": "autoland", 20:20:17 INFO - "repo_path": "integration/autoland", 20:20:17 INFO - "revision": "5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb", 20:20:17 INFO - "stage_platform": "linux64", 20:20:17 INFO - "builduid": "b0763ebf714e434e987f30804fa9b1ce", 20:20:17 INFO - "slavebuilddir": "test" 20:20:17 INFO - } 20:20:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:20:17 INFO - Running post-action listener: _resource_record_post_action 20:20:17 INFO - ##### 20:20:17 INFO - ##### Finished read-buildbot-config step (success) 20:20:17 INFO - ##### 20:20:17 INFO - ##### 20:20:17 INFO - ##### Running download-and-extract step. 20:20:17 INFO - ##### 20:20:17 INFO - Running pre-action listener: _resource_record_pre_action 20:20:17 INFO - Running main action method: download_and_extract 20:20:17 INFO - mkdir: /builds/slave/test/build/tests 20:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:17 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:20:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:20:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:20:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:20:26 INFO - Downloaded 1361 bytes. 20:20:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:20:26 INFO - Using the following test package requirements: 20:20:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:20:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:20:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:26 INFO - u'jsshell-linux-x86_64.zip'], 20:20:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:20:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:20:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:20:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:20:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:20:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:20:26 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')]} 20:20:26 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:20:32 INFO - Downloaded 22700530 bytes. 20:20:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:20:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:20:33 INFO - Return code: 0 20:20:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:20: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')]} 20:20:33 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:20:36 INFO - Downloaded 22700530 bytes. 20:20:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:20:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:20:37 INFO - Return code: 0 20:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:37 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:20:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:20:38 INFO - Downloaded 14405245 bytes. 20:20:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:20:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:20:38 INFO - Return code: 0 20:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:38 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:20:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:20:40 INFO - Downloaded 56438136 bytes. 20:20:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:40 INFO - mkdir: /builds/slave/test/properties 20:20:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:20:40 INFO - Writing to file /builds/slave/test/properties/build_url 20:20:40 INFO - Contents: 20:20:40 INFO - build_url:https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:40 INFO - Running post-action listener: _resource_record_post_action 20:20:40 INFO - Running post-action listener: set_extra_try_arguments 20:20:40 INFO - ##### 20:20:40 INFO - ##### Finished download-and-extract step (success) 20:20:40 INFO - ##### 20:20:40 INFO - ##### 20:20:40 INFO - ##### Running populate-webroot step. 20:20:40 INFO - ##### 20:20:40 INFO - Running pre-action listener: _resource_record_pre_action 20:20:40 INFO - Running main action method: populate_webroot 20:20:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:20:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:20:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:20:41 INFO - '--tppagecycles', 20:20:41 INFO - '7'], 20:20:41 INFO - 'tests': ['tsvgm']}}, 20:20:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:20:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:20:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:20:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:20:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:41 INFO - 'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:41 INFO - 'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['damp', 'tps']}, 20:20:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:41 INFO - 'tests': ['damp', 'tps']}, 20:20:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['dromaeo_dom']}, 20:20:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:20:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['basic_compositor_video']}, 20:20:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:20:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['a11yr', 20:20:41 INFO - 'ts_paint', 20:20:41 INFO - 'tpaint', 20:20:41 INFO - 'sessionrestore', 20:20:41 INFO - 'sessionrestore_no_auto_restore', 20:20:41 INFO - 'tabpaint']}, 20:20:41 INFO - 'other-e10s': {'tests': ['a11yr', 20:20:41 INFO - 'ts_paint', 20:20:41 INFO - 'tpaint', 20:20:41 INFO - 'sessionrestore', 20:20:41 INFO - 'sessionrestore_no_auto_restore', 20:20:41 INFO - 'tabpaint']}, 20:20:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:20:41 INFO - 'ts_paint', 20:20:41 INFO - 'tpaint', 20:20:41 INFO - 'sessionrestore', 20:20:41 INFO - 'sessionrestore_no_auto_restore', 20:20:41 INFO - 'tabpaint']}, 20:20:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:20:41 INFO - 'ts_paint', 20:20:41 INFO - 'tpaint', 20:20:41 INFO - 'sessionrestore', 20:20:41 INFO - 'sessionrestore_no_auto_restore', 20:20:41 INFO - 'tabpaint']}, 20:20:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['a11yr', 20:20:41 INFO - 'ts_paint', 20:20:41 INFO - 'tpaint', 20:20:41 INFO - 'sessionrestore', 20:20:41 INFO - 'sessionrestore_no_auto_restore', 20:20:41 INFO - 'tabpaint']}, 20:20:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['a11yr', 20:20:41 INFO - 'ts_paint', 20:20:41 INFO - 'tpaint', 20:20:41 INFO - 'sessionrestore', 20:20:41 INFO - 'sessionrestore_no_auto_restore', 20:20:41 INFO - 'tabpaint']}, 20:20:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['tsvgx', 20:20:41 INFO - 'tsvgr_opacity', 20:20:41 INFO - 'tart', 20:20:41 INFO - 'tscrollx', 20:20:41 INFO - 'cart']}, 20:20:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:20:41 INFO - 'tsvgr_opacity', 20:20:41 INFO - 'tart', 20:20:41 INFO - 'tscrollx', 20:20:41 INFO - 'cart']}, 20:20:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:41 INFO - 'talos_options': ['--disable-e10s'], 20:20:41 INFO - 'tests': ['tp5o']}, 20:20:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:41 INFO - 'tests': ['tp5o']}, 20:20:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:41 INFO - 'talos_options': ['--disable-e10s', 20:20:41 INFO - '--xperf_path', 20:20:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:41 INFO - 'tests': ['tp5n']}, 20:20:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:41 INFO - 'talos_options': ['--xperf_path', 20:20:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:41 INFO - 'tests': ['tp5n']}}, 20:20:41 INFO - 'talos.zip': {'path': '', 20:20:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:20:41 INFO - Running post-action listener: _resource_record_post_action 20:20:41 INFO - ##### 20:20:41 INFO - ##### Finished populate-webroot step (success) 20:20:41 INFO - ##### 20:20:41 INFO - ##### 20:20:41 INFO - ##### Running create-virtualenv step. 20:20:41 INFO - ##### 20:20:41 INFO - Running pre-action listener: _resource_record_pre_action 20:20:41 INFO - Running main action method: create_virtualenv 20:20:41 INFO - Creating virtualenv /builds/slave/test/build/venv 20:20:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:20:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:20:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:20:41 INFO - Using real prefix '/usr' 20:20:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:20:41 INFO - Installing distribute.............................................................................................................................................................................................done. 20:20:43 INFO - Installing pip.................done. 20:20:43 INFO - Return code: 0 20:20:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:20:43 INFO - Using env: {'DISPLAY': ':0', 20:20:43 INFO - 'HOME': '/home/cltbld', 20:20:43 INFO - 'LANG': 'en_US.UTF-8', 20:20:43 INFO - 'LANGUAGE': 'en_US:en', 20:20:43 INFO - 'LOGNAME': 'cltbld', 20:20:43 INFO - 'MAIL': '/var/mail/cltbld', 20:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:43 INFO - 'MOZ_NO_REMOTE': '1', 20:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:43 INFO - 'NO_EM_RESTART': '1', 20:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:43 INFO - 'PWD': '/builds/slave/test', 20:20:43 INFO - 'SHELL': '/bin/bash', 20:20:43 INFO - 'SHLVL': '1', 20:20:43 INFO - 'TERM': 'linux', 20:20:43 INFO - 'TMOUT': '86400', 20:20:43 INFO - 'USER': 'cltbld', 20:20:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:43 INFO - '_': '/tools/buildbot/bin/python'} 20:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:43 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 20:20:43 INFO - Cleaning up... 20:20:43 INFO - Return code: 0 20:20:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:20: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 psutil>=3.1.1 20:20:43 INFO - Using env: {'DISPLAY': ':0', 20:20:43 INFO - 'HOME': '/home/cltbld', 20:20:43 INFO - 'LANG': 'en_US.UTF-8', 20:20:43 INFO - 'LANGUAGE': 'en_US:en', 20:20:43 INFO - 'LOGNAME': 'cltbld', 20:20:43 INFO - 'MAIL': '/var/mail/cltbld', 20:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:43 INFO - 'MOZ_NO_REMOTE': '1', 20:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:43 INFO - 'NO_EM_RESTART': '1', 20:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:43 INFO - 'PWD': '/builds/slave/test', 20:20:43 INFO - 'SHELL': '/bin/bash', 20:20:43 INFO - 'SHLVL': '1', 20:20:43 INFO - 'TERM': 'linux', 20:20:43 INFO - 'TMOUT': '86400', 20:20:43 INFO - 'USER': 'cltbld', 20:20:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:43 INFO - '_': '/tools/buildbot/bin/python'} 20:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:44 INFO - Downloading/unpacking psutil>=3.1.1 20:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:20:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:46 INFO - Installing collected packages: psutil 20:20:46 INFO - Running setup.py install for psutil 20:20:46 INFO - building 'psutil._psutil_linux' extension 20:20:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:20:46 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 20:20:46 INFO - building 'psutil._psutil_posix' extension 20:20:46 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 20:20:46 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 20:20:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:46 INFO - Successfully installed psutil 20:20:46 INFO - Cleaning up... 20:20:46 INFO - Return code: 0 20:20:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:46 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:20:46 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.3'] in /builds/slave/test/build 20:20:46 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.3 20:20:46 INFO - Using env: {'DISPLAY': ':0', 20:20:46 INFO - 'HOME': '/home/cltbld', 20:20:46 INFO - 'LANG': 'en_US.UTF-8', 20:20:46 INFO - 'LANGUAGE': 'en_US:en', 20:20:46 INFO - 'LOGNAME': 'cltbld', 20:20:46 INFO - 'MAIL': '/var/mail/cltbld', 20:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:46 INFO - 'MOZ_NO_REMOTE': '1', 20:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:46 INFO - 'NO_EM_RESTART': '1', 20:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:46 INFO - 'PWD': '/builds/slave/test', 20:20:46 INFO - 'SHELL': '/bin/bash', 20:20:46 INFO - 'SHLVL': '1', 20:20:46 INFO - 'TERM': 'linux', 20:20:46 INFO - 'TMOUT': '86400', 20:20:46 INFO - 'USER': 'cltbld', 20:20:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:46 INFO - '_': '/tools/buildbot/bin/python'} 20:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:20:48 INFO - Installing collected packages: mozsystemmonitor 20:20:48 INFO - Running setup.py install for mozsystemmonitor 20:20:48 INFO - Successfully installed mozsystemmonitor 20:20:48 INFO - Cleaning up... 20:20:48 INFO - Return code: 0 20:20:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:20:48 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')]} 20:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:48 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')]} 20:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:48 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:20:48 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==2.5.1'] in /builds/slave/test/build 20:20:48 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==2.5.1 20:20:48 INFO - Using env: {'DISPLAY': ':0', 20:20:48 INFO - 'HOME': '/home/cltbld', 20:20:48 INFO - 'LANG': 'en_US.UTF-8', 20:20:48 INFO - 'LANGUAGE': 'en_US:en', 20:20:48 INFO - 'LOGNAME': 'cltbld', 20:20:48 INFO - 'MAIL': '/var/mail/cltbld', 20:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:48 INFO - 'MOZ_NO_REMOTE': '1', 20:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:48 INFO - 'NO_EM_RESTART': '1', 20:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:48 INFO - 'PWD': '/builds/slave/test', 20:20:48 INFO - 'SHELL': '/bin/bash', 20:20:48 INFO - 'SHLVL': '1', 20:20:48 INFO - 'TERM': 'linux', 20:20:48 INFO - 'TMOUT': '86400', 20:20:48 INFO - 'USER': 'cltbld', 20:20:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:48 INFO - '_': '/tools/buildbot/bin/python'} 20:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:49 INFO - Downloading/unpacking jsonschema==2.5.1 20:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:20:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:51 INFO - Downloading functools32-3.2.3-2.tar.gz 20:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:20:51 INFO - warning: no files found matching '*.txt' 20:20:51 INFO - no previously-included directories found matching 'build' 20:20:51 INFO - no previously-included directories found matching 'dist' 20:20:51 INFO - no previously-included directories found matching '.git*' 20:20:51 INFO - Installing collected packages: jsonschema, functools32 20:20:51 INFO - Running setup.py install for functools32 20:20:51 INFO - warning: no files found matching '*.txt' 20:20:51 INFO - no previously-included directories found matching 'build' 20:20:51 INFO - no previously-included directories found matching 'dist' 20:20:51 INFO - no previously-included directories found matching '.git*' 20:20:51 INFO - Successfully installed jsonschema functools32 20:20:51 INFO - Cleaning up... 20:20:51 INFO - Return code: 0 20:20:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:20:51 INFO - Using env: {'DISPLAY': ':0', 20:20:51 INFO - 'HOME': '/home/cltbld', 20:20:51 INFO - 'LANG': 'en_US.UTF-8', 20:20:51 INFO - 'LANGUAGE': 'en_US:en', 20:20:51 INFO - 'LOGNAME': 'cltbld', 20:20:51 INFO - 'MAIL': '/var/mail/cltbld', 20:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:51 INFO - 'MOZ_NO_REMOTE': '1', 20:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:51 INFO - 'NO_EM_RESTART': '1', 20:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:51 INFO - 'PWD': '/builds/slave/test', 20:20:51 INFO - 'SHELL': '/bin/bash', 20:20:51 INFO - 'SHLVL': '1', 20:20:51 INFO - 'TERM': 'linux', 20:20:51 INFO - 'TMOUT': '86400', 20:20:51 INFO - 'USER': 'cltbld', 20:20:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:51 INFO - '_': '/tools/buildbot/bin/python'} 20:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:51 INFO - Downloading/unpacking blobuploader==1.2.4 20:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:53 INFO - Downloading blobuploader-1.2.4.tar.gz 20:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:20:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:20:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:20:54 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 20:20:54 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 20:20:54 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 20:20:54 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 20:20:54 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 20:20:54 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 20:20:54 INFO - Downloading docopt-0.6.1.tar.gz 20:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:20:54 INFO - Installing collected packages: blobuploader, requests, docopt 20:20:54 INFO - Running setup.py install for blobuploader 20:20:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:20:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:20:54 INFO - Running setup.py install for requests 20:20:54 INFO - Running setup.py install for docopt 20:20:54 INFO - Successfully installed blobuploader requests docopt 20:20:54 INFO - Cleaning up... 20:20:55 INFO - Return code: 0 20:20:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:55 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')]} 20:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:55 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')]} 20:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:55 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 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:20:55 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 20:20:55 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 20:20:55 INFO - Using env: {'DISPLAY': ':0', 20:20:55 INFO - 'HOME': '/home/cltbld', 20:20:55 INFO - 'LANG': 'en_US.UTF-8', 20:20:55 INFO - 'LANGUAGE': 'en_US:en', 20:20:55 INFO - 'LOGNAME': 'cltbld', 20:20:55 INFO - 'MAIL': '/var/mail/cltbld', 20:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:55 INFO - 'MOZ_NO_REMOTE': '1', 20:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:55 INFO - 'NO_EM_RESTART': '1', 20:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:55 INFO - 'PWD': '/builds/slave/test', 20:20:55 INFO - 'SHELL': '/bin/bash', 20:20:55 INFO - 'SHLVL': '1', 20:20:55 INFO - 'TERM': 'linux', 20:20:55 INFO - 'TMOUT': '86400', 20:20:55 INFO - 'USER': 'cltbld', 20:20:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:55 INFO - '_': '/tools/buildbot/bin/python'} 20:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:55 INFO - Running setup.py (path:/tmp/pip-MbgcBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:55 INFO - Running setup.py (path:/tmp/pip-w73nqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:55 INFO - Running setup.py (path:/tmp/pip-zKCpN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:55 INFO - Running setup.py (path:/tmp/pip-WruDib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:55 INFO - Running setup.py (path:/tmp/pip-OGP696-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:55 INFO - Running setup.py (path:/tmp/pip-iznQNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:55 INFO - Running setup.py (path:/tmp/pip-QSIpN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:55 INFO - Running setup.py (path:/tmp/pip-4Xk3_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:55 INFO - Running setup.py (path:/tmp/pip-lzoBT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:55 INFO - Running setup.py (path:/tmp/pip-36rQAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:55 INFO - Running setup.py (path:/tmp/pip-Cv6lU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:56 INFO - Running setup.py (path:/tmp/pip-fg_6og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:56 INFO - Running setup.py (path:/tmp/pip-nQ34yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:56 INFO - Running setup.py (path:/tmp/pip-RyCNMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:56 INFO - Running setup.py (path:/tmp/pip-0sxSh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:56 INFO - Running setup.py (path:/tmp/pip-DNf4p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:56 INFO - Running setup.py (path:/tmp/pip-NeRsL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:20:56 INFO - Running setup.py install for manifestparser 20:20:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:20:56 INFO - Running setup.py install for mozcrash 20:20:56 INFO - Running setup.py install for mozdebug 20:20:56 INFO - Running setup.py install for mozdevice 20:20:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:20:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:20:56 INFO - Running setup.py install for mozfile 20:20:57 INFO - Running setup.py install for mozhttpd 20:20:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Running setup.py install for mozinfo 20:20:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Running setup.py install for mozInstall 20:20:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Running setup.py install for mozleak 20:20:57 INFO - Running setup.py install for mozlog 20:20:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Running setup.py install for moznetwork 20:20:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Running setup.py install for mozprocess 20:20:57 INFO - Running setup.py install for mozprofile 20:20:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Running setup.py install for mozrunner 20:20:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:20:57 INFO - Running setup.py install for mozscreenshot 20:20:58 INFO - Running setup.py install for moztest 20:20:58 INFO - Running setup.py install for mozversion 20:20:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:20:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:20:58 INFO - Cleaning up... 20:20:58 INFO - Return code: 0 20:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:58 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 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:20:58 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 20:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:20:58 INFO - Using env: {'DISPLAY': ':0', 20:20:58 INFO - 'HOME': '/home/cltbld', 20:20:58 INFO - 'LANG': 'en_US.UTF-8', 20:20:58 INFO - 'LANGUAGE': 'en_US:en', 20:20:58 INFO - 'LOGNAME': 'cltbld', 20:20:58 INFO - 'MAIL': '/var/mail/cltbld', 20:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:58 INFO - 'MOZ_NO_REMOTE': '1', 20:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:58 INFO - 'NO_EM_RESTART': '1', 20:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:58 INFO - 'PWD': '/builds/slave/test', 20:20:58 INFO - 'SHELL': '/bin/bash', 20:20:58 INFO - 'SHLVL': '1', 20:20:58 INFO - 'TERM': 'linux', 20:20:58 INFO - 'TMOUT': '86400', 20:20:58 INFO - 'USER': 'cltbld', 20:20:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:58 INFO - '_': '/tools/buildbot/bin/python'} 20:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:58 INFO - Running setup.py (path:/tmp/pip-izIkBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:58 INFO - Running setup.py (path:/tmp/pip-PCM7OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:58 INFO - Running setup.py (path:/tmp/pip-VWo_qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:58 INFO - Running setup.py (path:/tmp/pip-dXGx5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:58 INFO - Running setup.py (path:/tmp/pip-1Bshcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:58 INFO - Running setup.py (path:/tmp/pip-uX8pYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:58 INFO - Running setup.py (path:/tmp/pip-zq6t2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:59 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)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:59 INFO - Running setup.py (path:/tmp/pip-4m70Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:59 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)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:59 INFO - Running setup.py (path:/tmp/pip-7GXem6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:59 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)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:59 INFO - Running setup.py (path:/tmp/pip-M0tKnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:59 INFO - Running setup.py (path:/tmp/pip-tMf7W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:59 INFO - Running setup.py (path:/tmp/pip-g1RqMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:59 INFO - Running setup.py (path:/tmp/pip-lvFDai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:59 INFO - Running setup.py (path:/tmp/pip-yLZaVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:59 INFO - Running setup.py (path:/tmp/pip-xum1U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:59 INFO - Running setup.py (path:/tmp/pip-6c6YqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:59 INFO - Running setup.py (path:/tmp/pip-YFpeCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:20:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:21:02 INFO - Downloading blessings-1.6.tar.gz 20:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:21:02 INFO - Installing collected packages: blessings 20:21:02 INFO - Running setup.py install for blessings 20:21:02 INFO - Successfully installed blessings 20:21:02 INFO - Cleaning up... 20:21:02 INFO - Return code: 0 20:21:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:21:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:21:03 INFO - Reading from file tmpfile_stdout 20:21:03 INFO - Current package versions: 20:21:03 INFO - argparse == 1.2.1 20:21:03 INFO - blessings == 1.6 20:21:03 INFO - blobuploader == 1.2.4 20:21:03 INFO - docopt == 0.6.1 20:21:03 INFO - functools32 == 3.2.3-2 20:21:03 INFO - jsonschema == 2.5.1 20:21:03 INFO - manifestparser == 1.1 20:21:03 INFO - mozInstall == 1.12 20:21:03 INFO - mozcrash == 0.17 20:21:03 INFO - mozdebug == 0.1 20:21:03 INFO - mozdevice == 0.48 20:21:03 INFO - mozfile == 1.2 20:21:03 INFO - mozhttpd == 0.7 20:21:03 INFO - mozinfo == 0.9 20:21:03 INFO - mozleak == 0.1 20:21:03 INFO - mozlog == 3.2 20:21:03 INFO - moznetwork == 0.27 20:21:03 INFO - mozprocess == 0.22 20:21:03 INFO - mozprofile == 0.28 20:21:03 INFO - mozrunner == 6.11 20:21:03 INFO - mozscreenshot == 0.1 20:21:03 INFO - mozsystemmonitor == 0.3 20:21:03 INFO - moztest == 0.7 20:21:03 INFO - mozversion == 1.4 20:21:03 INFO - psutil == 3.1.1 20:21:03 INFO - requests == 1.2.3 20:21:03 INFO - wsgiref == 0.1.2 20:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:03 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 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:21:03 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 20:21:03 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 20:21:03 INFO - Using env: {'DISPLAY': ':0', 20:21:03 INFO - 'HOME': '/home/cltbld', 20:21:03 INFO - 'LANG': 'en_US.UTF-8', 20:21:03 INFO - 'LANGUAGE': 'en_US:en', 20:21:03 INFO - 'LOGNAME': 'cltbld', 20:21:03 INFO - 'MAIL': '/var/mail/cltbld', 20:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:03 INFO - 'MOZ_NO_REMOTE': '1', 20:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:03 INFO - 'NO_EM_RESTART': '1', 20:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:03 INFO - 'PWD': '/builds/slave/test', 20:21:03 INFO - 'SHELL': '/bin/bash', 20:21:03 INFO - 'SHLVL': '1', 20:21:03 INFO - 'TERM': 'linux', 20:21:03 INFO - 'TMOUT': '86400', 20:21:03 INFO - 'USER': 'cltbld', 20:21:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:03 INFO - '_': '/tools/buildbot/bin/python'} 20:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 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)) 20:21:03 INFO - Cleaning up... 20:21:03 INFO - Return code: 0 20:21:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:03 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 0x1fd7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, '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': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', '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 20:21:03 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 20:21:03 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 20:21:03 INFO - Using env: {'DISPLAY': ':0', 20:21:03 INFO - 'HOME': '/home/cltbld', 20:21:03 INFO - 'LANG': 'en_US.UTF-8', 20:21:03 INFO - 'LANGUAGE': 'en_US:en', 20:21:03 INFO - 'LOGNAME': 'cltbld', 20:21:03 INFO - 'MAIL': '/var/mail/cltbld', 20:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:03 INFO - 'MOZ_NO_REMOTE': '1', 20:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:03 INFO - 'NO_EM_RESTART': '1', 20:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:03 INFO - 'PWD': '/builds/slave/test', 20:21:03 INFO - 'SHELL': '/bin/bash', 20:21:03 INFO - 'SHLVL': '1', 20:21:03 INFO - 'TERM': 'linux', 20:21:03 INFO - 'TMOUT': '86400', 20:21:03 INFO - 'USER': 'cltbld', 20:21:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:03 INFO - '_': '/tools/buildbot/bin/python'} 20:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:21:03 INFO - Cleaning up... 20:21:03 INFO - Return code: 0 20:21:03 INFO - Running post-action listener: _resource_record_post_action 20:21:03 INFO - Running post-action listener: _start_resource_monitoring 20:21:03 INFO - Starting resource monitoring. 20:21:03 INFO - ##### 20:21:03 INFO - ##### Finished create-virtualenv step (success) 20:21:03 INFO - ##### 20:21:03 INFO - ##### 20:21:03 INFO - ##### Running install step. 20:21:03 INFO - ##### 20:21:03 INFO - Running pre-action listener: _resource_record_pre_action 20:21:03 INFO - Running main action method: install 20:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:21:03 INFO - Reading from file tmpfile_stdout 20:21:03 INFO - Detecting whether we're running mozinstall >=1.0... 20:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:21:03 INFO - Reading from file tmpfile_stdout 20:21:03 INFO - Output received: 20:21:03 INFO - Usage: mozinstall [options] installer 20:21:03 INFO - Options: 20:21:03 INFO - -h, --help show this help message and exit 20:21:03 INFO - -d DEST, --destination=DEST 20:21:03 INFO - Directory to install application into. [default: 20:21:03 INFO - "/builds/slave/test"] 20:21:03 INFO - --app=APP Application being installed. [default: firefox] 20:21:03 INFO - mkdir: /builds/slave/test/build/application 20:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:21:20 INFO - Reading from file tmpfile_stdout 20:21:20 INFO - Output received: 20:21:20 INFO - /builds/slave/test/build/application/firefox/firefox 20:21:20 INFO - Running post-action listener: _resource_record_post_action 20:21:20 INFO - ##### 20:21:20 INFO - ##### Finished install step (success) 20:21:20 INFO - ##### 20:21:20 INFO - ##### 20:21:20 INFO - ##### Running run-tests step. 20:21:20 INFO - ##### 20:21:20 INFO - Running pre-action listener: _resource_record_pre_action 20:21:20 INFO - Running main action method: run_tests 20:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:21:20 INFO - Python 2.7.3 20:21:20 INFO - Return code: 0 20:21:20 INFO - grabbing minidump binary from tooltool 20:21:20 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')]} 20:21:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295570>, '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 0x2296470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:21:20 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 20:21:20 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 20:21:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:21:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:21:20 INFO - Return code: 0 20:21:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:21:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:21:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:21:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:21:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 20:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 20:21:20 INFO - Using env: {'DISPLAY': ':0', 20:21:20 INFO - 'HOME': '/home/cltbld', 20:21:20 INFO - 'LANG': 'en_US.UTF-8', 20:21:20 INFO - 'LANGUAGE': 'en_US:en', 20:21:20 INFO - 'LOGNAME': 'cltbld', 20:21:20 INFO - 'MAIL': '/var/mail/cltbld', 20:21:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:21:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:20 INFO - 'MOZ_NO_REMOTE': '1', 20:21:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:20 INFO - 'NO_EM_RESTART': '1', 20:21:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:20 INFO - 'PWD': '/builds/slave/test', 20:21:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:21:20 INFO - 'SHELL': '/bin/bash', 20:21:20 INFO - 'SHLVL': '1', 20:21:20 INFO - 'TERM': 'linux', 20:21:20 INFO - 'TMOUT': '86400', 20:21:20 INFO - 'USER': 'cltbld', 20:21:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467169601.771539-1207476424', 20:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:20 INFO - '_': '/tools/buildbot/bin/python'} 20:21:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 20:21:20 INFO - mozversion application_buildid: 20160628192830 20:21:20 INFO - mozversion application_changeset: 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb 20:21:20 INFO - mozversion application_display_name: Nightly 20:21:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:21:20 INFO - mozversion application_name: Firefox 20:21:20 INFO - mozversion application_remotingname: firefox 20:21:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:21:20 INFO - mozversion application_vendor: Mozilla 20:21:20 INFO - mozversion application_version: 50.0a1 20:21:20 INFO - mozversion platform_buildid: 20160628192830 20:21:20 INFO - mozversion platform_changeset: 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb 20:21:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:21:20 INFO - mozversion platform_version: 50.0a1 20:21:20 INFO - using testdate: 1467170480 20:21:20 INFO - actual date: 1467170480 20:21:20 INFO - starting webserver on 'localhost:36547' 20:21:20 INFO - SUITE-START | Running 2 tests 20:21:20 INFO - TEST-START | dromaeo_css 20:21:20 INFO - operating with platform_type : linux_ 20:21:20 INFO - Initialising browser for dromaeo_css test... 20:21:20 INFO - TEST-INFO | started process 25418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8FQBNP/profile http://localhost:36547/getInfo.html) 20:21:25 INFO - PROCESS | 25418 | __metrics Screen width/height:1600/1200 20:21:25 INFO - PROCESS | 25418 | colorDepth:24 20:21:25 INFO - PROCESS | 25418 | Browser inner width/height: 1024/697 20:21:25 INFO - PROCESS | 25418 | __metrics 20:21:26 ERROR - PROCESS | 25418 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:21:27 INFO - TEST-INFO | 25418: exit 0 20:21:27 INFO - Browser initialized. 20:21:27 INFO - Running cycle 1/1 for dromaeo_css test... 20:21:27 INFO - TEST-INFO | started process 25536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8FQBNP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:39 INFO - PROCESS | 25536 | RSS: Main: 169381888 20:21:39 INFO - PROCESS | 25536 | 20:22:28 INFO - PROCESS | 25536 | 1467170548671 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] 20:24:40 INFO - PROCESS | 25536 | Cycle 1(1): loaded http://localhost:36547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36547/tests/dromaeo/cssquery-ext.html) 20:24:41 INFO - PROCESS | 25536 | RSS: Main: 172802048 20:24:41 INFO - PROCESS | 25536 | 20:27:44 INFO - PROCESS | 25536 | Cycle 1(1): loaded http://localhost:36547/tests/dromaeo/cssquery-ext.html (next: http://localhost:36547/tests/dromaeo/cssquery-jquery.html) 20:27:44 INFO - PROCESS | 25536 | RSS: Main: 171720704 20:27:44 INFO - PROCESS | 25536 | 20:30:46 INFO - PROCESS | 25536 | Cycle 1(1): loaded http://localhost:36547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36547/tests/dromaeo/cssquery-mootools.html) 20:30:47 INFO - PROCESS | 25536 | RSS: Main: 172331008 20:30:47 INFO - PROCESS | 25536 | 20:33:48 INFO - PROCESS | 25536 | Cycle 1(1): loaded http://localhost:36547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36547/tests/dromaeo/cssquery-prototype.html) 20:33:49 INFO - PROCESS | 25536 | RSS: Main: 170401792 20:33:49 INFO - PROCESS | 25536 | 20:36:52 INFO - PROCESS | 25536 | Cycle 1(1): loaded http://localhost:36547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36547/tests/dromaeo/cssquery-yui.html) 20:36:52 INFO - PROCESS | 25536 | RSS: Main: 172539904 20:36:52 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | Cycle 1(1): loaded http://localhost:36547/tests/dromaeo/cssquery-yui.html (next: http://localhost:36547/tests/dromaeo/cssquery-dojo.html) 20:39:55 INFO - PROCESS | 25536 | RSS: Main: 173264896 20:39:55 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | __start_tp_report 20:39:55 INFO - PROCESS | 25536 | _x_x_mozilla_page_load 20:39:55 INFO - PROCESS | 25536 | _x_x_mozilla_page_load_details 20:39:55 INFO - PROCESS | 25536 | |i|pagename|runs| 20:39:55 INFO - PROCESS | 25536 | |0;dojo.html;2657.056744855576;2718.3747738020256;2719.9320016999573;2725.9045933392313;2738.972610273897;4885.487023862496;4893;4935.77788999495;4972.428170760364;5051.570616497593;4854.271859221119;4931.1617025105725;4946.356973593428;4949.430815456223;4983.700977941326;4499.460064792222;4520.50274469808;4636.397268355109;4636.51316611756;4652.604528615072;480.1340901298998;4448.866534003985;4488.214562451574;4538.614217791475;4588.862334129982;4543.045960348314;4549.567791059844;4553.430821147356;4571.588557029883;4598.839040633562;4585.220512512881;4588.609968152711;4595.172868883599;4601.079784043205;4638.8608341749805;4371.366151907987;4437.977810110961;4446.377507148969;4502.662300327489;4515.14212299662;4838.104950584118;4895.143349913787;4906.533879281498;4956.405231372259;4999.250112483121;5259.368875734898;5263.236830659533;5276.261323414725;5364.946350536484;5393.083175860113;5381.7196805226395;5395.082835917903;5409.918851217196;5420.4850539198715;5460.26286451328;4942.777575009133;4995.675281106716;5011.749412529359;5019.648624596243;5040.899182016413;5482.643628164156;5499.615026948075;5526.972365138229;5535.612507124462;5553.111502159635;5100.107481190851;5119.795208191631;5264.15773476242;5298.337707786527;5300.337457817773;5220.477952204825;5261.579073674096;5265.420803711589;5282.947170528322;5321.228421878884;5221.582273418117;5234.947650523446;5235.040613270324;5245.763940622681;5282.102042652758;5130.87172820675;5141.38303403594;5220.895582088337;5223.973880130575;5235.083860324428;4523.615492683093;4538.160440318486;4555.612772914273;4585.495595484494;4597.172508948422;3950.58518855516;3956.3274243378696;3971.4042893566198;3993.800309984489;4008.198360327946;4495.2582823834355;4582.152301824173;4624.329472226508;4658.138244424792;4718.598919091847;5166.948330516722;5286.074936886106;5288.418273989935;5312.76092575835;5363.356397232357;4612.584867361954;4629.236176030917;4634.003689206769;4634.629229661619;4686.367340409001;4685.81256749733;4806.95193048072;4808.519148085164;4847.127517046895;4908.288298196813;5046.419661738947;5089.440161582149;5093.388793344897;5093.541581257705;5131.87170320745;5404.162354835007;5424.810131645373;5426.484483974016;5437.918431223456;5461.044317244387;4849.393825771778;4972.453030166606;5003.974980125222;5032.6980381177245;5058.949410505995;5229.607779416635;5259.395169555397;5288.656237344714;5294.629375943647;5317.069512835315;5383.973080134574;5392.164214546751;5393.595480339069;5395.946040539544;5431.185322201702;5090;5149.948500514947;5181.896362072662;5209.47905209476;5221.947780522146;5230.215467679878;5230.790768369223;5235.136202526541;5242.449542797951;5242.659227150223;4932.30947667334;5126.128558145049;5145.253938178868;5155.046316431472;5168.224766284937;5149.613778966517;5183.870403239949;5191.662541934762;5208.322918020633;5220.295260139833;5122.871928201825;5125.641205115755;5127.79488820443;5131.127708289525;5137.023965446553 20:39:55 INFO - PROCESS | 25536 | |1;ext.html;581.581261491726;596.2636144361712;599.5233789137634;611.9779967454351;647.6340867409916;33744.831275843615;34513.30973380531;36823.4476482853;36835;36857.44713829295;36668.633313666855;37528.624713752855;37535.62464375355;37577.812110939405;37591;7499.962500187505;7668.808279793022;7710.421718371116;7786.454948153631;7801.531908085533;7544.735934242302;7580.393568514533;7614.200508946564;7616.276453736886;7631.732889348874;7650.961745191266;7677.078750549942;7717.614119294041;7730.342920851735;7739.419543534229;7471.962640186792;7626.275503827128;7628.809279768023;7653.885191722128;7671.041119860018;7604.163542010375;7669.923300766976;7700.653470593837;7708.537487750753;7710.421718371144;35369.29261414758;35841.46237806435;35919;35933.82033089844;35937.82031089854;2457.7050753909466;2691.232998595391;3098.690130986906;3294.357600267949;3785.0348161218712;27863.517060367452;28267.293317667016;28379.71620283812;28598.285042873886;28668.71331286702;3255.7069863712145;3256.299895522474;3294.0941241158635;3313.188268874141;3330.700236978659;234347;234596;234930;235520;236756;31929.201769955936;32644.83677581597;32661.346773064404;32872.67127328744;33093.3381332372;34007.4898876517;34130;34304.65695343065;34307.313853722786;34391.484127738106;13393.531226407029;13511.256880871646;13598.912087033013;13620.65948351299;13625.591232263048;11305.32168069902;11327.94336028331;11337.376444295644;11337.43312834355;11469.770604588028;7899.0521137463875;7936.722214722572;7940.841183176304;7962.761117166378;8058.677652893936;3124.906252812419;3127.280725433118;3155.857986390618;3160.9367812644077;3168.4296826570976;889.4440974391006;901.1484147480699;901.6258252825004;908.4322298563397;975.3903810118676;27722.168334949984;28517.73385508811;28567;28604.85697571499;28905.42189156205;913.5204017890661;957.9377340472847;961.7643677298967;970.9077637624414;1019.8674172357546;14826.703465930621;15149.166795826115;15223.771643425136;15290.388384464719;15469.458568950033;401312;406632;408047;408401;408483;50283.74858125686;51129.74435127875;51355.486445135815;51730.224046639334;51887;1163.0811658789462;1176.4294317256124;1182.320165904591;1204.10895937006;1223.2721530689225;27083.1875043749;27875.16374508768;27911.581326279716;27991.30021749391;28604.284892877844;43170.35244471273;43634.781826090664;43646.12707745891;43690.56309436992;43728.781356093015;327603;331575;335626;335882;338415;25492.23523294304;26046.479070418107;26085.869570652027;26122.477550449265;26227.213183604523;41147.58852411557;42556.14887702167;42807.448332309315;43129.56870431381;43391;37123;37248;37248.44127338038;37331.2533749318;37883;37433.438498422;37557.248855023296;37911.43132852954;38385;38661;35996.28007439889;36040.27919441649;36642.63357366392;37025.07437313981;37351.25297494089;31950.84024579955;33538.16154596155;33894.83052584721;34205.31589368149;34215.144621384665;25679.229623111336;25751.227463176136;25943;25988.350291242114;26010.609840852023 20:39:55 INFO - PROCESS | 25536 | |2;jquery.html;352.36222437388346;361.461422480504;365.08181922464996;371.86612819385;375.24201113750223;16037.51887443377;16460.50618481446;17323.653526929455;17515.12424378779;17553.210105545248;15748.448804291853;15994.200289985483;16713.916430417863;16747;16781.24484398202;4908.288298196769;5074.974625126869;5120.667156634807;5138.820141295056;5140.8971820563565;5050.267711181895;5089.84730458085;5166.095933211692;5170.043541944733;5178.792848286064;5012.122878496267;5060.721660308682;5068.467810879842;5080.669756465818;5123.923141152885;5037.722925239111;5127.461616530267;5131.692098474085;5135.332406787131;5139.999999999981;4446.266366049598;4535.365048893158;4537.069900670388;4564.109998550284;4564.475085365192;19401;19715.802841971683;20190.19239230429;20318.492037699027;20436.38690839277;1934.806519348068;1965.6756635155325;2016.2842191022123;2498.100683753847;2499.7750202481866;13178.86821131786;13359.198448093048;13642.522511712043;13648.089267502557;13698.246596437191;1724.284421964883;1749.1750822421825;1757.6045389787323;1814.600787826676;1828;60420.69789651024;63661.36338636647;63700.362996369906;64013.35986640167;64079;9235.815283694288;9281.118293762082;9377.390469619453;9405;9468.289878259158;12596.685082872818;12699.936500317439;12763.872361276453;12793;12827.807582886264;7241.565506069653;7250.9637451812405;7297.525660832029;7465.738699145504;7502.924970750222;6916.861662766716;6943.479239057091;6988.965055174692;6989.7553585624255;7184.353408193288;6075.422834830684;6080.7871724490315;6117.663528505975;6154.59995100326;6172.753089876444;1740.25169177255;1766.381766381756;1842.5301548105415;1854.1007611308505;1855.0631930874822;803.9638216280281;877.9473231606124;893.1068931068932;927.8283517549276;951.9286053546011;16234.594135146715;16681.666366672842;16939.407120750962;17150;17462.91268543649;859.3340161374985;881.0660699658382;883.2095274729081;889.9288056955428;897.3001059173855;9476.57355418994;9912.653057142965;10038.74903127413;10066.496675166212;10140;372355;376995;379020;387357;416114;54927.72536137294;63197.52413617295;63794.68102659457;65793.34206657873;67067.32932670708;924.7179610218948;960.1742501448748;969.6848524229654;979.5689896445541;987.980240395188;15431.99692020015;15506.9224653876;15552.92223538875;15837.762433563736;15947.521574352788;36449.45325820062;38162.42756358712;38482.61517384902;38923.610763892;39146.804265978484;52333.7383313081;53281;53599.73200133974;54241.45758542364;54578.72710636421;7448.73929412468;7715.22847715224;7815.694370160702;7827.765167044998;7865.252800983897;8369.372297077865;8501.787455313666;8596.441231320194;8608.78478038054;8701.695440659547;7314.524555903849;7432.108147022392;7583.7724868254045;7624.656890439833;7662.501937374052;7526.09686837583;7756.961215193888;7783.883241751265;7839.764807055797;7856.803579910548;7508.887366689613;7684.397587955646;7769.261920117579;7866.6066696666085;7896.447248692536;10726.141908647445;11464;11816.763664726486;11880.643580692593;11967.760644786882;9629.277804164576;9846.113849753556;10218.795624087625;10278.126359259546;10499.950004999439 20:39:55 INFO - PROCESS | 25536 | |3;mootools.html;1375.8899288056953;1406.5991192510135;1473.4695509616536;1643.589102724319;1656.5361698724362;6656.933430665692;7423.331900128994;7472.626368681571;7907.802304942372;7970.800729981754;7575.128860181081;7725.227477252286;7733;7748.53508789473;7804.531728096318;2178.596959562478;2224.343818573525;2225.3991422315967;2234.832387570939;2237.19460994042;2176.923807666732;2186.278528085728;2206.3932418584936;2229.1752051740796;2237.2393386248673;2193.046024979139;2214.435318993654;2217.7116974793335;2224.699665545155;2224.810891074261;2181.2692747929464;2185.945351366213;2186.147402513021;2186.464316242515;2202.8458007939453;2173.3371321746863;2183.148572056899;2190.9452263693374;2196.9450763730874;2201.2075652764993;7722.768316950444;7797.220277972214;7807.6876924922935;7846.293833555007;7863.9776829012435;4599.08018396322;4720.905581888343;4726.834560790356;4738.668293219476;4741.57325840676;2914.7959642825012;2958.600588920511;3001.4597372472945;3059.969400305991;3076.3385872037397;952.380952380951;1009.3237530854345;1022.4274406332478;1025.2310766924807;1025.7025462615832;10476.1095306899;10564.049235568837;10594.152467802558;10621.362718236931;10647.201459890463;4124.896877578025;4225.9577404225565;4306.20335237982;4306.956930430656;4317.956820431818;9038.141376569216;9092.454452732858;9098.044705305847;9106.681266155652;9134.132257435665;4740.715557066587;4745.383100197021;4752.144613969519;4755.881102972384;4767.976160119178;3726.720495962814;4137.317342638491;4223.535411104776;4281.593248641374;4340.544242854518;3666.6333366663653;3667.7982710951155;3742.0831896185064;3782.413725872494;3885.941710874339;1170.4791367841399;1173.4426147580002;1180.533689192764;1180.557291015869;1186.2348785033605;806.161591944383;831.3764676492631;834.5451728807693;839.886615306938;860.8966923969164;5030.84907452777;5236.764345604457;5268.578513718893;5322.866928326745;5364.409914909357;408.0940312506231;411.80027686571987;416.3421793566158;419.9160167966419;421.3448088222843;3262.9184270392957;3263.1352691536763;3283.737301015913;3322.651121632242;3331.1838599543266;9205.723828285161;9395.295352848563;9403.106704863027;9500.667476638284;9512.28657850664;9407.43555386679;9409.952950235205;9438.52807359643;9467.195288400426;9478.289128315266;6967.442604591621;7112.857742845217;7217.458690598226;7255.746048888158;7267.418606511466;4924.8276310328965;4983.07813054586;5030.245463180552;5041.395032596112;5055.16589762685;8655.611430395993;8754.562271886507;8850.778730531789;8883.555822208735;8909.55452227399;8784.516851573226;8805.075467076122;8959.41763785352;9044.321675874467;9065.093490651147;6051.515878729603;6666.300038496082;6871.175458944958;6890.345417185359;6925.861482770417;7570.735024274124;7575.24247575238;7622.733204337822;7636.923630763844;7682.961585192038;6639.336066393322;6823.420009299265;6862.279460656759;6896.965515172392;6898.310168983062;6677.198736151693;6716.1604799400075;6733.3939945405145;6748.426383757435;6907.827304317432;6322.114903913548;6327.145835312358;6346.904796427965;6416.807495775134;6466.482681385572;4390.3414487827085;4398.648108151404;4417.580329868657;4424.225760491965;4426.690131690751;4326.783660817009;4355.998120432381;4378.715383500063;4463.2635615123145;4523.411956445641 20:39:55 INFO - PROCESS | 25536 | |4;prototype.html;303.8571871220526;304.13928582112624;305.97552195824335;309.32258354204305;310.29717689433437;5100.31145795318;5145.871353216172;5162.741862906859;5175.731945673306;5258.6318957672975;5117.616178786588;5139.691618502883;5144.356955380577;5144.739538812996;5182.481751824825;3836.616338366155;3914.432407300954;4058.492688413948;4075.7962101894936;4082.9387559186634;4049.6962727795385;4049.7975101244965;4063.5326937402283;4064.4351924508983;4070.715049946505;4011.3982902564558;4032.3145065338963;4048.696347773914;4049.473568436114;4060.3810542200263;3757.4927384802977;4036.5963403659694;4046.3930410438375;4057.431959525669;4062.9593704063172;3447.482877568385;3449.913752156191;3452.3095380923914;3455.844486998066;3459.2043829919257;5029.622778291606;5031.572316353115;5032.4212715537815;5035.647504674675;5059.139946209153;4577.56513131252;4587.655925805578;4592.2193227151465;4600.401947746805;4606.216943119678;5316.38861530925;5378.784848606051;5386.272853164812;5395.514403703685;5418.972905135489;3773.584905660375;3778.3199024175638;3786.3752480840903;3789.574672209788;3811.656950874407;5695.145728140812;5731.767669950939;5741.827745167651;5764.221830052973;5764.250647415809;3769.3026790043928;3847.633705271294;3868.168343806095;3877.495925529663;3878.670313023368;3876.437916502148;3905.6680182184264;3917.745346552465;3930.862419815293;3945.8027098644952;4516.977415112903;4538.092381523708;4554.7039442436135;4556.908861822745;4566.817327306937;5246.167069782351;5435.646682965595;5444.074507333763;5473.029709304647;5494.203340515603;1342.5032737887045;1360.5985834590388;1366.549038817188;1368.3363568669188;1376.800363947222;827.7185756842703;856.7900864288165;867.5141920524527;872.616048938465;877.1272583779053;4564.307058835237;4622.659428765687;4787.808487660454;4794.712317260975;4797.328374027639;5602.439756024446;5611.887762244733;5672.914906276326;5684.863027394537;5719.454842595089;4600.7929643166135;4785.473597904228;4811.975940120347;4815.30178124177;4826.444958829709;2969.6881827408242;2974.7471464925293;2975.3156773941682;2985.567092771536;3000.774941879324;5263.078991159867;5294.411676497036;5307.734613269321;5351.812686555952;5361.544268737123;5483;5702.600817942787;5748.252727145528;5765.567582431335;5779.508741756914;5225.634205605647;5235.712035838065;5241.659292146074;5253.500917412916;5311.707856067954;5622.803201887914;5644.858878527905;5651.4348565143155;5654.208410822571;5696.259486266925;5278.2346559749385;5482.506574408322;5494.2582751329655;5510.1459273812625;5532.28080349552;5224.738763061756;5317.415084340642;5336.839894803162;5339.492748188916;5358.062339090721;3905.726599138033;3940.4286378475535;3958.287508248543;3974.125692347679;3978.6419222270133;5397.703126327932;5675.26221591207;5686.800961966312;5697.6296540724725;5712.371639119777;5513.8345849624575;5531.838313953954;5546.584006199632;5553;5574.358948720949;5122.232829673757;5484.2047903053035;5485.451454854483;5511.5669925818775;5551.583631227593;5365.865853353697;5428.45715428454;5441.26542916717;5444.5916556259235;5448.700321482356;5269.868253293698;5312.867178320573;5466.91799622998;5482.506574408322;5532.474414930575;5361.169018802092;5431.185322201702;5441.401445840876;5454.372747133972;5493.807716729895 20:39:55 INFO - PROCESS | 25536 | |5;yui.html;689.7137687859536;697.8429853283011;723.2080871445766;731.8792399254123;744.8584768893907;11640.417979101043;13002.73994520109;13511.121777084507;13615.659608509792;13668.316584170789;13639.318034098305;13706.520271790489;13717.519886803964;13743.587692369245;13788.931055344734;610.6244659534376;787.1538096546221;793.7261644732558;793.7896457438783;795.4352409789057;773.0684525147212;792.5244853088159;794.4200733464575;796.1361922314296;798.1061211443192;835.9164083591653;843.8692002739555;844.501743971057;846.7713717296326;847.3644766425181;818.2553875972836;827.664795757719;827.8634025385804;835.9665613375457;836.9121242269565;605.4036773777825;607.419913982146;608.2062907905182;608.9847753806146;609.9268087829445;12714.237145771283;12723.618291451272;12753.553625623059;12783.93608031954;12993.155444896052;12157.574484892986;12300.200486968319;12330.383480826013;12455.626331210078;13527.391267392892;10282.434466104361;10479.63321283759;10632.627858024933;10694.197935154816;10705.25063245573;3265.4611989021782;3308.503724441329;3324.4680851063713;3327.184839714261;3413.1467133216697;62969.68515157395;63450.682746585975;63993;64975.3502464974;65018.674906625165;10303.845442318372;10420.531849103192;10496.475176241158;10642.521086551124;10699.090577300862;18997.43007709771;19098.045097745056;19107.426777196706;19196.90401548011;19198.8080119197;6408.070829729756;6540.738370465128;6809.404363752194;6820.147481564804;7122.252163522756;3694.649008344203;3787.9431808522895;3808.990617486368;3830.0807806126327;3854.3557393797237;2999.355138645202;3096.4735994880925;3111.346617210366;3114.9065528034193;3117.6726443723537;507.2973931105372;525.0601423451978;531.9175527793199;534.8796520782793;538.7979507684619;478.55255336260706;495.5490503641741;510.40792680491194;522.8091746512572;523.2804893271751;8087.150849160871;8320.500769953822;8320.625571849161;8321.916780832114;8414.537200454033;565.2595100418465;569.2770181869004;578.2222910185793;582.5514353947436;583.585654185533;3770.9434358484646;3829.3681542545723;3851.171998020439;4111;4282.721623094489;96029.51985240029;98201;98636;98843.50578247063;99729.50135249278;89822;91841.54079229561;91959;92226;92642.53678731564;77713;79953.60023199963;80151;81353.89845761473;82673.58663206766;8514.74455766328;8546.78633034179;8608;8747.693830715894;8752;46272.30591541197;46528;47966.28050579174;48144.51855481401;48251;59366.40633593609;59821.70089149527;66774.66612666905;67315;69022.30977690159;11117.729398099915;11231.326120432474;11304.378259195822;11395.487203075716;11698.06415486742;12499;12511.374431278582;12637.684057898627;12940.870591294342;12973.610791676265;11587;11699.88300116988;11786.646400607995;11957.701057473632;12695.492180312684;11509.136814739095;11572.544570340648;11618.593349232737;11991.400429978641;12313.322767247888;10514.26400151982;11174.944125279322;11176.832347514632;11385.943070284595;11562.595309164139;9981;10146.847797282899;10238.641647542301;10286.845697314697;10491.94754026225;10127.594896204364;10141.239407044353;10265.538050787583;10435.37387756737;10488.370697758159 20:39:55 INFO - PROCESS | 25536 | __end_tp_report 20:39:55 INFO - PROCESS | 25536 | __start_cc_report 20:39:55 INFO - PROCESS | 25536 | _x_x_mozilla_cycle_collect,391 20:39:55 INFO - PROCESS | 25536 | __end_cc_report 20:39:55 INFO - PROCESS | 25536 | __startTimestamp1467171595829__endTimestamp 20:39:55 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | ------- Summary: start ------- 20:39:55 INFO - PROCESS | 25536 | Number of tests: 6 20:39:55 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | [#0] dojo.html Cycles:165 Average:4893.88 Median:5089.44 stddev:629.70 (12.4%) stddev-sans-first:606.69 20:39:55 INFO - PROCESS | 25536 | Values: 2657.1 2718.4 2719.9 2725.9 2739.0 4885.5 4893.0 4935.8 4972.4 5051.6 4854.3 4931.2 4946.4 4949.4 4983.7 4499.5 4520.5 4636.4 4636.5 4652.6 480.1 4448.9 4488.2 4538.6 4588.9 4543.0 4549.6 4553.4 4571.6 4598.8 4585.2 4588.6 4595.2 4601.1 4638.9 4371.4 4438.0 4446.4 4502.7 4515.1 4838.1 4895.1 4906.5 4956.4 4999.3 5259.4 5263.2 5276.3 5364.9 5393.1 5381.7 5395.1 5409.9 5420.5 5460.3 4942.8 4995.7 5011.7 5019.6 5040.9 5482.6 5499.6 5527.0 5535.6 5553.1 5100.1 5119.8 5264.2 5298.3 5300.3 5220.5 5261.6 5265.4 5282.9 5321.2 5221.6 5234.9 5235.0 5245.8 5282.1 5130.9 5141.4 5220.9 5224.0 5235.1 4523.6 4538.2 4555.6 4585.5 4597.2 3950.6 3956.3 3971.4 3993.8 4008.2 4495.3 4582.2 4624.3 4658.1 4718.6 5166.9 5286.1 5288.4 5312.8 5363.4 4612.6 4629.2 4634.0 4634.6 4686.4 4685.8 4807.0 4808.5 4847.1 4908.3 5046.4 5089.4 5093.4 5093.5 5131.9 5404.2 5424.8 5426.5 5437.9 5461.0 4849.4 4972.5 5004.0 5032.7 5058.9 5229.6 5259.4 5288.7 5294.6 5317.1 5384.0 5392.2 5393.6 5395.9 5431.2 5090.0 5149.9 5181.9 5209.5 5221.9 5230.2 5230.8 5235.1 5242.4 5242.7 4932.3 5126.1 5145.3 5155.0 5168.2 5149.6 5183.9 5191.7 5208.3 5220.3 5122.9 5125.6 5127.8 5131.1 5137.0 20:39:55 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | [#1] ext.html Cycles:180 Average:46403.24 Median:35935.82 stddev:87978.14 (244.8%) stddev-sans-first:88157.68 20:39:55 INFO - PROCESS | 25536 | Values: 581.6 596.3 599.5 612.0 647.6 33744.8 34513.3 36823.4 36835.0 36857.4 36668.6 37528.6 37535.6 37577.8 37591.0 7500.0 7668.8 7710.4 7786.5 7801.5 7544.7 7580.4 7614.2 7616.3 7631.7 7651.0 7677.1 7717.6 7730.3 7739.4 7472.0 7626.3 7628.8 7653.9 7671.0 7604.2 7669.9 7700.7 7708.5 7710.4 35369.3 35841.5 35919.0 35933.8 35937.8 2457.7 2691.2 3098.7 3294.4 3785.0 27863.5 28267.3 28379.7 28598.3 28668.7 3255.7 3256.3 3294.1 3313.2 3330.7 234347.0 234596.0 234930.0 235520.0 236756.0 31929.2 32644.8 32661.3 32872.7 33093.3 34007.5 34130.0 34304.7 34307.3 34391.5 13393.5 13511.3 13598.9 13620.7 13625.6 11305.3 11327.9 11337.4 11337.4 11469.8 7899.1 7936.7 7940.8 7962.8 8058.7 3124.9 3127.3 3155.9 3160.9 3168.4 889.4 901.1 901.6 908.4 975.4 27722.2 28517.7 28567.0 28604.9 28905.4 913.5 957.9 961.8 970.9 1019.9 14826.7 15149.2 15223.8 15290.4 15469.5 401312.0 406632.0 408047.0 408401.0 408483.0 50283.7 51129.7 51355.5 51730.2 51887.0 1163.1 1176.4 1182.3 1204.1 1223.3 27083.2 27875.2 27911.6 27991.3 28604.3 43170.4 43634.8 43646.1 43690.6 43728.8 327603.0 331575.0 335626.0 335882.0 338415.0 25492.2 26046.5 26085.9 26122.5 26227.2 41147.6 42556.1 42807.4 43129.6 43391.0 37123.0 37248.0 37248.4 37331.3 37883.0 37433.4 37557.2 37911.4 38385.0 38661.0 35996.3 36040.3 36642.6 37025.1 37351.3 31950.8 33538.2 33894.8 34205.3 34215.1 25679.2 25751.2 25943.0 25988.4 26010.6 20:39:55 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | [#2] jquery.html Cycles:180 Average:23640.12 Median:5122.30 stddev:63545.73 (1240.6%) stddev-sans-first:63699.94 20:39:55 INFO - PROCESS | 25536 | Values: 352.4 361.5 365.1 371.9 375.2 16037.5 16460.5 17323.7 17515.1 17553.2 15748.4 15994.2 16713.9 16747.0 16781.2 4908.3 5075.0 5120.7 5138.8 5140.9 5050.3 5089.8 5166.1 5170.0 5178.8 5012.1 5060.7 5068.5 5080.7 5123.9 5037.7 5127.5 5131.7 5135.3 5140.0 4446.3 4535.4 4537.1 4564.1 4564.5 19401.0 19715.8 20190.2 20318.5 20436.4 1934.8 1965.7 2016.3 2498.1 2499.8 13178.9 13359.2 13642.5 13648.1 13698.2 1724.3 1749.2 1757.6 1814.6 1828.0 60420.7 63661.4 63700.4 64013.4 64079.0 9235.8 9281.1 9377.4 9405.0 9468.3 12596.7 12699.9 12763.9 12793.0 12827.8 7241.6 7251.0 7297.5 7465.7 7502.9 6916.9 6943.5 6989.0 6989.8 7184.4 6075.4 6080.8 6117.7 6154.6 6172.8 1740.3 1766.4 1842.5 1854.1 1855.1 804.0 877.9 893.1 927.8 951.9 16234.6 16681.7 16939.4 17150.0 17462.9 859.3 881.1 883.2 889.9 897.3 9476.6 9912.7 10038.7 10066.5 10140.0 372355.0 376995.0 379020.0 387357.0 416114.0 54927.7 63197.5 63794.7 65793.3 67067.3 924.7 960.2 969.7 979.6 988.0 15432.0 15506.9 15552.9 15837.8 15947.5 36449.5 38162.4 38482.6 38923.6 39146.8 52333.7 53281.0 53599.7 54241.5 54578.7 7448.7 7715.2 7815.7 7827.8 7865.3 8369.4 8501.8 8596.4 8608.8 8701.7 7314.5 7432.1 7583.8 7624.7 7662.5 7526.1 7757.0 7783.9 7839.8 7856.8 7508.9 7684.4 7769.3 7866.6 7896.4 10726.1 11464.0 11816.8 11880.6 11967.8 9629.3 9846.1 10218.8 10278.1 10500.0 20:39:55 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | [#3] mootools.html Cycles:180 Average:5100.85 Median:4748.76 stddev:2856.41 (60.2%) stddev-sans-first:2850.71 20:39:55 INFO - PROCESS | 25536 | Values: 1375.9 1406.6 1473.5 1643.6 1656.5 6656.9 7423.3 7472.6 7907.8 7970.8 7575.1 7725.2 7733.0 7748.5 7804.5 2178.6 2224.3 2225.4 2234.8 2237.2 2176.9 2186.3 2206.4 2229.2 2237.2 2193.0 2214.4 2217.7 2224.7 2224.8 2181.3 2185.9 2186.1 2186.5 2202.8 2173.3 2183.1 2190.9 2196.9 2201.2 7722.8 7797.2 7807.7 7846.3 7864.0 4599.1 4720.9 4726.8 4738.7 4741.6 2914.8 2958.6 3001.5 3060.0 3076.3 952.4 1009.3 1022.4 1025.2 1025.7 10476.1 10564.0 10594.2 10621.4 10647.2 4124.9 4226.0 4306.2 4307.0 4318.0 9038.1 9092.5 9098.0 9106.7 9134.1 4740.7 4745.4 4752.1 4755.9 4768.0 3726.7 4137.3 4223.5 4281.6 4340.5 3666.6 3667.8 3742.1 3782.4 3885.9 1170.5 1173.4 1180.5 1180.6 1186.2 806.2 831.4 834.5 839.9 860.9 5030.8 5236.8 5268.6 5322.9 5364.4 408.1 411.8 416.3 419.9 421.3 3262.9 3263.1 3283.7 3322.7 3331.2 9205.7 9395.3 9403.1 9500.7 9512.3 9407.4 9410.0 9438.5 9467.2 9478.3 6967.4 7112.9 7217.5 7255.7 7267.4 4924.8 4983.1 5030.2 5041.4 5055.2 8655.6 8754.6 8850.8 8883.6 8909.6 8784.5 8805.1 8959.4 9044.3 9065.1 6051.5 6666.3 6871.2 6890.3 6925.9 7570.7 7575.2 7622.7 7636.9 7683.0 6639.3 6823.4 6862.3 6897.0 6898.3 6677.2 6716.2 6733.4 6748.4 6907.8 6322.1 6327.1 6346.9 6416.8 6466.5 4390.3 4398.6 4417.6 4424.2 4426.7 4326.8 4356.0 4378.7 4463.3 4523.4 20:39:55 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | [#4] prototype.html Cycles:180 Average:4508.32 Median:5145.31 stddev:1335.70 (26.0%) stddev-sans-first:1301.63 20:39:55 INFO - PROCESS | 25536 | Values: 303.9 304.1 306.0 309.3 310.3 5100.3 5145.9 5162.7 5175.7 5258.6 5117.6 5139.7 5144.4 5144.7 5182.5 3836.6 3914.4 4058.5 4075.8 4082.9 4049.7 4049.8 4063.5 4064.4 4070.7 4011.4 4032.3 4048.7 4049.5 4060.4 3757.5 4036.6 4046.4 4057.4 4063.0 3447.5 3449.9 3452.3 3455.8 3459.2 5029.6 5031.6 5032.4 5035.6 5059.1 4577.6 4587.7 4592.2 4600.4 4606.2 5316.4 5378.8 5386.3 5395.5 5419.0 3773.6 3778.3 3786.4 3789.6 3811.7 5695.1 5731.8 5741.8 5764.2 5764.3 3769.3 3847.6 3868.2 3877.5 3878.7 3876.4 3905.7 3917.7 3930.9 3945.8 4517.0 4538.1 4554.7 4556.9 4566.8 5246.2 5435.6 5444.1 5473.0 5494.2 1342.5 1360.6 1366.5 1368.3 1376.8 827.7 856.8 867.5 872.6 877.1 4564.3 4622.7 4787.8 4794.7 4797.3 5602.4 5611.9 5672.9 5684.9 5719.5 4600.8 4785.5 4812.0 4815.3 4826.4 2969.7 2974.7 2975.3 2985.6 3000.8 5263.1 5294.4 5307.7 5351.8 5361.5 5483.0 5702.6 5748.3 5765.6 5779.5 5225.6 5235.7 5241.7 5253.5 5311.7 5622.8 5644.9 5651.4 5654.2 5696.3 5278.2 5482.5 5494.3 5510.1 5532.3 5224.7 5317.4 5336.8 5339.5 5358.1 3905.7 3940.4 3958.3 3974.1 3978.6 5397.7 5675.3 5686.8 5697.6 5712.4 5513.8 5531.8 5546.6 5553.0 5574.4 5122.2 5484.2 5485.5 5511.6 5551.6 5365.9 5428.5 5441.3 5444.6 5448.7 5269.9 5312.9 5466.9 5482.5 5532.5 5361.2 5431.2 5441.4 5454.4 5493.8 20:39:55 INFO - PROCESS | 25536 | 20:39:55 INFO - PROCESS | 25536 | [#5] yui.html Cycles:180 Average:18393.57 Median:23503.28 stddev:26586.10 (113.1%) stddev-sans-first:26627.45 20:39:55 INFO - PROCESS | 25536 | Values: 689.7 697.8 723.2 731.9 744.9 11640.4 13002.7 13511.1 13615.7 13668.3 13639.3 13706.5 13717.5 13743.6 13788.9 610.6 787.2 793.7 793.8 795.4 773.1 792.5 794.4 796.1 798.1 835.9 843.9 844.5 846.8 847.4 818.3 827.7 827.9 836.0 836.9 605.4 607.4 608.2 609.0 609.9 12714.2 12723.6 12753.6 12783.9 12993.2 12157.6 12300.2 12330.4 12455.6 13527.4 10282.4 10479.6 10632.6 10694.2 10705.3 3265.5 3308.5 3324.5 3327.2 3413.1 62969.7 63450.7 63993.0 64975.4 65018.7 10303.8 10420.5 10496.5 10642.5 10699.1 18997.4 19098.0 19107.4 19196.9 19198.8 6408.1 6540.7 6809.4 6820.1 7122.3 3694.6 3787.9 3809.0 3830.1 3854.4 2999.4 3096.5 3111.3 3114.9 3117.7 507.3 525.1 531.9 534.9 538.8 478.6 495.5 510.4 522.8 523.3 8087.2 8320.5 8320.6 8321.9 8414.5 565.3 569.3 578.2 582.6 583.6 3770.9 3829.4 3851.2 4111.0 4282.7 96029.5 98201.0 98636.0 98843.5 99729.5 89822.0 91841.5 91959.0 92226.0 92642.5 77713.0 79953.6 80151.0 81353.9 82673.6 8514.7 8546.8 8608.0 8747.7 8752.0 46272.3 46528.0 47966.3 48144.5 48251.0 59366.4 59821.7 66774.7 67315.0 69022.3 11117.7 11231.3 11304.4 11395.5 11698.1 12499.0 12511.4 12637.7 12940.9 12973.6 11587.0 11699.9 11786.6 11957.7 12695.5 11509.1 11572.5 11618.6 11991.4 12313.3 10514.3 11174.9 11176.8 11385.9 11562.6 9981.0 10146.8 10238.6 10286.8 10491.9 10127.6 10141.2 10265.5 10435.4 10488.4 20:39:55 INFO - PROCESS | 25536 | -------- Summary: end -------- 20:39:55 INFO - PROCESS | 25536 | 20:39:56 INFO - TEST-INFO | 25536: exit 0 20:39:56 INFO - TEST-OK | dromaeo_css | took 1116187ms 20:39:56 INFO - TEST-START | kraken 20:39:56 INFO - operating with platform_type : linux_ 20:39:56 INFO - Initialising browser for kraken test... 20:39:56 INFO - TEST-INFO | started process 25763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF30SAj/profile http://localhost:36547/getInfo.html) 20:40:01 INFO - PROCESS | 25763 | __metrics Screen width/height:1600/1200 20:40:01 INFO - PROCESS | 25763 | colorDepth:24 20:40:01 INFO - PROCESS | 25763 | Browser inner width/height: 1024/697 20:40:01 INFO - PROCESS | 25763 | __metrics 20:40:02 ERROR - PROCESS | 25763 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:40:03 INFO - TEST-INFO | 25763: exit 0 20:40:03 INFO - Browser initialized. 20:40:03 INFO - Running cycle 1/1 for kraken test... 20:40:03 INFO - TEST-INFO | started process 25880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF30SAj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:40:15 INFO - PROCESS | 25880 | RSS: Main: 169238528 20:40:15 INFO - PROCESS | 25880 | 20:40:17 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36547/tests/kraken/driver.html?testName=audio-beat-detection) 20:40:18 INFO - PROCESS | 25880 | RSS: Main: 174329856 20:40:18 INFO - PROCESS | 25880 | 20:40:21 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36547/tests/kraken/driver.html?testName=audio-dft) 20:40:22 INFO - PROCESS | 25880 | RSS: Main: 174120960 20:40:22 INFO - PROCESS | 25880 | 20:40:25 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36547/tests/kraken/driver.html?testName=audio-fft) 20:40:25 INFO - PROCESS | 25880 | RSS: Main: 169078784 20:40:25 INFO - PROCESS | 25880 | 20:40:27 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36547/tests/kraken/driver.html?testName=audio-oscillator) 20:40:28 INFO - PROCESS | 25880 | RSS: Main: 169484288 20:40:28 INFO - PROCESS | 25880 | 20:40:30 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:40:31 INFO - PROCESS | 25880 | RSS: Main: 169832448 20:40:31 INFO - PROCESS | 25880 | 20:40:34 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36547/tests/kraken/driver.html?testName=imaging-darkroom) 20:40:35 INFO - PROCESS | 25880 | RSS: Main: 169943040 20:40:35 INFO - PROCESS | 25880 | 20:40:38 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36547/tests/kraken/driver.html?testName=imaging-desaturate) 20:40:39 INFO - PROCESS | 25880 | RSS: Main: 167526400 20:40:39 INFO - PROCESS | 25880 | 20:40:42 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36547/tests/kraken/driver.html?testName=json-parse-financial) 20:40:42 INFO - PROCESS | 25880 | RSS: Main: 169197568 20:40:42 INFO - PROCESS | 25880 | 20:40:44 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:40:45 INFO - PROCESS | 25880 | RSS: Main: 169779200 20:40:45 INFO - PROCESS | 25880 | 20:40:47 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36547/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:40:47 INFO - PROCESS | 25880 | RSS: Main: 169590784 20:40:47 INFO - PROCESS | 25880 | 20:40:50 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:40:50 INFO - PROCESS | 25880 | RSS: Main: 170119168 20:40:50 INFO - PROCESS | 25880 | 20:40:53 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:40:54 INFO - PROCESS | 25880 | RSS: Main: 169906176 20:40:54 INFO - PROCESS | 25880 | 20:40:57 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:40:57 INFO - PROCESS | 25880 | RSS: Main: 169910272 20:40:57 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | Cycle 1(1): loaded http://localhost:36547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36547/tests/kraken/driver.html?testName=ai-astar) 20:40:59 INFO - PROCESS | 25880 | RSS: Main: 170745856 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | __start_tp_report 20:40:59 INFO - PROCESS | 25880 | _x_x_mozilla_page_load 20:40:59 INFO - PROCESS | 25880 | _x_x_mozilla_page_load_details 20:40:59 INFO - PROCESS | 25880 | |i|pagename|runs| 20:40:59 INFO - PROCESS | 25880 | |0;ai-astar;105;114;106;115;112;114;114;113;113;114 20:40:59 INFO - PROCESS | 25880 | |1;audio-beat-detection;174;151;161;180;135;158;157;135;195;133 20:40:59 INFO - PROCESS | 25880 | |2;audio-dft;163;165;168;172;166;164;164;165;161;165 20:40:59 INFO - PROCESS | 25880 | |3;audio-fft;75;76;75;148;76;76;76;76;165;85 20:40:59 INFO - PROCESS | 25880 | |4;audio-oscillator;88;87;139;85;87;88;136;88;86;141 20:40:59 INFO - PROCESS | 25880 | |5;imaging-gaussian-blur;118;118;118;117;118;118;117;118;117;118 20:40:59 INFO - PROCESS | 25880 | |6;imaging-darkroom;149;148;147;149;147;147;148;149;147;148 20:40:59 INFO - PROCESS | 25880 | |7;imaging-desaturate;96;95;95;96;95;96;95;95;96;96 20:40:59 INFO - PROCESS | 25880 | |8;json-parse-financial;64;65;65;64;64;63;71;65;64;65 20:40:59 INFO - PROCESS | 25880 | |9;json-stringify-tinderbox;64;65;65;65;65;65;64;65;65;66 20:40:59 INFO - PROCESS | 25880 | |10;stanford-crypto-aes;86;82;86;85;84;90;89;85;98;83 20:40:59 INFO - PROCESS | 25880 | |11;stanford-crypto-ccm;143;132;139;133;130;132;142;133;136;132 20:40:59 INFO - PROCESS | 25880 | |12;stanford-crypto-pbkdf2;168;166;163;165;170;168;168;169;165;165 20:40:59 INFO - PROCESS | 25880 | |13;stanford-crypto-sha256-iterative;67;68;68;71;69;66;65;67;68;66 20:40:59 INFO - PROCESS | 25880 | __end_tp_report 20:40:59 INFO - PROCESS | 25880 | __start_cc_report 20:40:59 INFO - PROCESS | 25880 | _x_x_mozilla_cycle_collect,957 20:40:59 INFO - PROCESS | 25880 | __end_cc_report 20:40:59 INFO - PROCESS | 25880 | __startTimestamp1467171659618__endTimestamp 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | ------- Summary: start ------- 20:40:59 INFO - PROCESS | 25880 | Number of tests: 14 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#0] ai-astar Cycles:10 Average:112.00 Median:114.00 stddev:3.53 (3.1%) stddev-sans-first:2.68 20:40:59 INFO - PROCESS | 25880 | Values: 105.0 114.0 106.0 115.0 112.0 114.0 114.0 113.0 113.0 114.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:159.50 stddev:20.69 (13.0%) stddev-sans-first:21.10 20:40:59 INFO - PROCESS | 25880 | Values: 174.0 151.0 161.0 180.0 135.0 158.0 157.0 135.0 195.0 133.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:2.98 (1.8%) stddev-sans-first:3.05 20:40:59 INFO - PROCESS | 25880 | Values: 163.0 165.0 168.0 172.0 166.0 164.0 164.0 165.0 161.0 165.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:33.94 (44.7%) stddev-sans-first:35.38 20:40:59 INFO - PROCESS | 25880 | Values: 75.0 76.0 75.0 148.0 76.0 76.0 76.0 76.0 165.0 85.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:87.00 stddev:25.00 (28.7%) stddev-sans-first:25.96 20:40:59 INFO - PROCESS | 25880 | Values: 88.0 87.0 139.0 85.0 87.0 88.0 136.0 88.0 86.0 141.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:40:59 INFO - PROCESS | 25880 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 20:40:59 INFO - PROCESS | 25880 | Values: 149.0 148.0 147.0 149.0 147.0 147.0 148.0 149.0 147.0 148.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:40:59 INFO - PROCESS | 25880 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:2.21 (3.4%) stddev-sans-first:2.32 20:40:59 INFO - PROCESS | 25880 | Values: 64.0 65.0 65.0 64.0 64.0 63.0 71.0 65.0 64.0 65.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 20:40:59 INFO - PROCESS | 25880 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 66.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:4.64 (5.4%) stddev-sans-first:4.91 20:40:59 INFO - PROCESS | 25880 | Values: 86.0 82.0 86.0 85.0 84.0 90.0 89.0 85.0 98.0 83.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:134.50 stddev:4.59 (3.4%) stddev-sans-first:3.91 20:40:59 INFO - PROCESS | 25880 | Values: 143.0 132.0 139.0 133.0 130.0 132.0 142.0 133.0 136.0 132.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:168.00 stddev:2.21 (1.3%) stddev-sans-first:2.30 20:40:59 INFO - PROCESS | 25880 | Values: 168.0 166.0 163.0 165.0 170.0 168.0 168.0 169.0 165.0 165.0 20:40:59 INFO - PROCESS | 25880 | 20:40:59 INFO - PROCESS | 25880 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.72 (2.5%) stddev-sans-first:1.81 20:40:59 INFO - PROCESS | 25880 | Values: 67.0 68.0 68.0 71.0 69.0 66.0 65.0 67.0 68.0 66.0 20:40:59 INFO - PROCESS | 25880 | -------- Summary: end -------- 20:40:59 INFO - PROCESS | 25880 | 20:41:00 INFO - TEST-INFO | 25880: exit 0 20:41:00 INFO - TEST-OK | kraken | took 64125ms 20:41:00 INFO - SUITE-END | took 1180s 20:41:00 INFO - Completed test suite (00:19:40) 20:41:00 INFO - javascript benchmark 20:41:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6426.755026239944, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.056744855576, 2718.3747738020256, 2719.9320016999573, 2725.9045933392313, 2738.972610273897, 4885.487023862496, 4893.0, 4935.77788999495, 4972.428170760364, 5051.570616497593, 4854.271859221119, 4931.1617025105725, 4946.356973593428, 4949.430815456223, 4983.700977941326, 4499.460064792222, 4520.50274469808, 4636.397268355109, 4636.51316611756, 4652.604528615072, 480.1340901298998, 4448.866534003985, 4488.214562451574, 4538.614217791475, 4588.862334129982, 4543.045960348314, 4549.567791059844, 4553.430821147356, 4571.588557029883, 4598.839040633562, 4585.220512512881, 4588.609968152711, 4595.172868883599, 4601.079784043205, 4638.8608341749805, 4371.366151907987, 4437.977810110961, 4446.377507148969, 4502.662300327489, 4515.14212299662, 4838.104950584118, 4895.143349913787, 4906.533879281498, 4956.405231372259, 4999.250112483121, 5259.368875734898, 5263.236830659533, 5276.261323414725, 5364.946350536484, 5393.083175860113, 5381.7196805226395, 5395.082835917903, 5409.918851217196, 5420.4850539198715, 5460.26286451328, 4942.777575009133, 4995.675281106716, 5011.749412529359, 5019.648624596243, 5040.899182016413, 5482.643628164156, 5499.615026948075, 5526.972365138229, 5535.612507124462, 5553.111502159635, 5100.107481190851, 5119.795208191631, 5264.15773476242, 5298.337707786527, 5300.337457817773, 5220.477952204825, 5261.579073674096, 5265.420803711589, 5282.947170528322, 5321.228421878884, 5221.582273418117, 5234.947650523446, 5235.040613270324, 5245.763940622681, 5282.102042652758, 5130.87172820675, 5141.38303403594, 5220.895582088337, 5223.973880130575, 5235.083860324428, 4523.615492683093, 4538.160440318486, 4555.612772914273, 4585.495595484494, 4597.172508948422, 3950.58518855516, 3956.3274243378696, 3971.4042893566198, 3993.800309984489, 4008.198360327946, 4495.2582823834355, 4582.152301824173, 4624.329472226508, 4658.138244424792, 4718.598919091847, 5166.948330516722, 5286.074936886106, 5288.418273989935, 5312.76092575835, 5363.356397232357, 4612.584867361954, 4629.236176030917, 4634.003689206769, 4634.629229661619, 4686.367340409001, 4685.81256749733, 4806.95193048072, 4808.519148085164, 4847.127517046895, 4908.288298196813, 5046.419661738947, 5089.440161582149, 5093.388793344897, 5093.541581257705, 5131.87170320745, 5404.162354835007, 5424.810131645373, 5426.484483974016, 5437.918431223456, 5461.044317244387, 4849.393825771778, 4972.453030166606, 5003.974980125222, 5032.6980381177245, 5058.949410505995, 5229.607779416635, 5259.395169555397, 5288.656237344714, 5294.629375943647, 5317.069512835315, 5383.973080134574, 5392.164214546751, 5393.595480339069, 5395.946040539544, 5431.185322201702, 5090.0, 5149.948500514947, 5181.896362072662, 5209.47905209476, 5221.947780522146, 5230.215467679878, 5230.790768369223, 5235.136202526541, 5242.449542797951, 5242.659227150223, 4932.30947667334, 5126.128558145049, 5145.253938178868, 5155.046316431472, 5168.224766284937, 5149.613778966517, 5183.870403239949, 5191.662541934762, 5208.322918020633, 5220.295260139833, 5122.871928201825, 5125.641205115755, 5127.79488820443, 5131.127708289525, 5137.023965446553], "value": 4854.478727953652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.581261491726, 596.2636144361712, 599.5233789137634, 611.9779967454351, 647.6340867409916, 33744.831275843615, 34513.30973380531, 36823.4476482853, 36835.0, 36857.44713829295, 36668.633313666855, 37528.624713752855, 37535.62464375355, 37577.812110939405, 37591.0, 7499.962500187505, 7668.808279793022, 7710.421718371116, 7786.454948153631, 7801.531908085533, 7544.735934242302, 7580.393568514533, 7614.200508946564, 7616.276453736886, 7631.732889348874, 7650.961745191266, 7677.078750549942, 7717.614119294041, 7730.342920851735, 7739.419543534229, 7471.962640186792, 7626.275503827128, 7628.809279768023, 7653.885191722128, 7671.041119860018, 7604.163542010375, 7669.923300766976, 7700.653470593837, 7708.537487750753, 7710.421718371144, 35369.29261414758, 35841.46237806435, 35919.0, 35933.82033089844, 35937.82031089854, 2457.7050753909466, 2691.232998595391, 3098.690130986906, 3294.357600267949, 3785.0348161218712, 27863.517060367452, 28267.293317667016, 28379.71620283812, 28598.285042873886, 28668.71331286702, 3255.7069863712145, 3256.299895522474, 3294.0941241158635, 3313.188268874141, 3330.700236978659, 234347.0, 234596.0, 234930.0, 235520.0, 236756.0, 31929.201769955936, 32644.83677581597, 32661.346773064404, 32872.67127328744, 33093.3381332372, 34007.4898876517, 34130.0, 34304.65695343065, 34307.313853722786, 34391.484127738106, 13393.531226407029, 13511.256880871646, 13598.912087033013, 13620.65948351299, 13625.591232263048, 11305.32168069902, 11327.94336028331, 11337.376444295644, 11337.43312834355, 11469.770604588028, 7899.0521137463875, 7936.722214722572, 7940.841183176304, 7962.761117166378, 8058.677652893936, 3124.906252812419, 3127.280725433118, 3155.857986390618, 3160.9367812644077, 3168.4296826570976, 889.4440974391006, 901.1484147480699, 901.6258252825004, 908.4322298563397, 975.3903810118676, 27722.168334949984, 28517.73385508811, 28567.0, 28604.85697571499, 28905.42189156205, 913.5204017890661, 957.9377340472847, 961.7643677298967, 970.9077637624414, 1019.8674172357546, 14826.703465930621, 15149.166795826115, 15223.771643425136, 15290.388384464719, 15469.458568950033, 401312.0, 406632.0, 408047.0, 408401.0, 408483.0, 50283.74858125686, 51129.74435127875, 51355.486445135815, 51730.224046639334, 51887.0, 1163.0811658789462, 1176.4294317256124, 1182.320165904591, 1204.10895937006, 1223.2721530689225, 27083.1875043749, 27875.16374508768, 27911.581326279716, 27991.30021749391, 28604.284892877844, 43170.35244471273, 43634.781826090664, 43646.12707745891, 43690.56309436992, 43728.781356093015, 327603.0, 331575.0, 335626.0, 335882.0, 338415.0, 25492.23523294304, 26046.479070418107, 26085.869570652027, 26122.477550449265, 26227.213183604523, 41147.58852411557, 42556.14887702167, 42807.448332309315, 43129.56870431381, 43391.0, 37123.0, 37248.0, 37248.44127338038, 37331.2533749318, 37883.0, 37433.438498422, 37557.248855023296, 37911.43132852954, 38385.0, 38661.0, 35996.28007439889, 36040.27919441649, 36642.63357366392, 37025.07437313981, 37351.25297494089, 31950.84024579955, 33538.16154596155, 33894.83052584721, 34205.31589368149, 34215.144621384665, 25679.229623111336, 25751.227463176136, 25943.0, 25988.350291242114, 26010.609840852023], "value": 16291.953955164965, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.36222437388346, 361.461422480504, 365.08181922464996, 371.86612819385, 375.24201113750223, 16037.51887443377, 16460.50618481446, 17323.653526929455, 17515.12424378779, 17553.210105545248, 15748.448804291853, 15994.200289985483, 16713.916430417863, 16747.0, 16781.24484398202, 4908.288298196769, 5074.974625126869, 5120.667156634807, 5138.820141295056, 5140.8971820563565, 5050.267711181895, 5089.84730458085, 5166.095933211692, 5170.043541944733, 5178.792848286064, 5012.122878496267, 5060.721660308682, 5068.467810879842, 5080.669756465818, 5123.923141152885, 5037.722925239111, 5127.461616530267, 5131.692098474085, 5135.332406787131, 5139.999999999981, 4446.266366049598, 4535.365048893158, 4537.069900670388, 4564.109998550284, 4564.475085365192, 19401.0, 19715.802841971683, 20190.19239230429, 20318.492037699027, 20436.38690839277, 1934.806519348068, 1965.6756635155325, 2016.2842191022123, 2498.100683753847, 2499.7750202481866, 13178.86821131786, 13359.198448093048, 13642.522511712043, 13648.089267502557, 13698.246596437191, 1724.284421964883, 1749.1750822421825, 1757.6045389787323, 1814.600787826676, 1828.0, 60420.69789651024, 63661.36338636647, 63700.362996369906, 64013.35986640167, 64079.0, 9235.815283694288, 9281.118293762082, 9377.390469619453, 9405.0, 9468.289878259158, 12596.685082872818, 12699.936500317439, 12763.872361276453, 12793.0, 12827.807582886264, 7241.565506069653, 7250.9637451812405, 7297.525660832029, 7465.738699145504, 7502.924970750222, 6916.861662766716, 6943.479239057091, 6988.965055174692, 6989.7553585624255, 7184.353408193288, 6075.422834830684, 6080.7871724490315, 6117.663528505975, 6154.59995100326, 6172.753089876444, 1740.25169177255, 1766.381766381756, 1842.5301548105415, 1854.1007611308505, 1855.0631930874822, 803.9638216280281, 877.9473231606124, 893.1068931068932, 927.8283517549276, 951.9286053546011, 16234.594135146715, 16681.666366672842, 16939.407120750962, 17150.0, 17462.91268543649, 859.3340161374985, 881.0660699658382, 883.2095274729081, 889.9288056955428, 897.3001059173855, 9476.57355418994, 9912.653057142965, 10038.74903127413, 10066.496675166212, 10140.0, 372355.0, 376995.0, 379020.0, 387357.0, 416114.0, 54927.72536137294, 63197.52413617295, 63794.68102659457, 65793.34206657873, 67067.32932670708, 924.7179610218948, 960.1742501448748, 969.6848524229654, 979.5689896445541, 987.980240395188, 15431.99692020015, 15506.9224653876, 15552.92223538875, 15837.762433563736, 15947.521574352788, 36449.45325820062, 38162.42756358712, 38482.61517384902, 38923.610763892, 39146.804265978484, 52333.7383313081, 53281.0, 53599.73200133974, 54241.45758542364, 54578.72710636421, 7448.73929412468, 7715.22847715224, 7815.694370160702, 7827.765167044998, 7865.252800983897, 8369.372297077865, 8501.787455313666, 8596.441231320194, 8608.78478038054, 8701.695440659547, 7314.524555903849, 7432.108147022392, 7583.7724868254045, 7624.656890439833, 7662.501937374052, 7526.09686837583, 7756.961215193888, 7783.883241751265, 7839.764807055797, 7856.803579910548, 7508.887366689613, 7684.397587955646, 7769.261920117579, 7866.6066696666085, 7896.447248692536, 10726.141908647445, 11464.0, 11816.763664726486, 11880.643580692593, 11967.760644786882, 9629.277804164576, 9846.113849753556, 10218.795624087625, 10278.126359259546, 10499.950004999439], "value": 8091.068467814404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.8899288056953, 1406.5991192510135, 1473.4695509616536, 1643.589102724319, 1656.5361698724362, 6656.933430665692, 7423.331900128994, 7472.626368681571, 7907.802304942372, 7970.800729981754, 7575.128860181081, 7725.227477252286, 7733.0, 7748.53508789473, 7804.531728096318, 2178.596959562478, 2224.343818573525, 2225.3991422315967, 2234.832387570939, 2237.19460994042, 2176.923807666732, 2186.278528085728, 2206.3932418584936, 2229.1752051740796, 2237.2393386248673, 2193.046024979139, 2214.435318993654, 2217.7116974793335, 2224.699665545155, 2224.810891074261, 2181.2692747929464, 2185.945351366213, 2186.147402513021, 2186.464316242515, 2202.8458007939453, 2173.3371321746863, 2183.148572056899, 2190.9452263693374, 2196.9450763730874, 2201.2075652764993, 7722.768316950444, 7797.220277972214, 7807.6876924922935, 7846.293833555007, 7863.9776829012435, 4599.08018396322, 4720.905581888343, 4726.834560790356, 4738.668293219476, 4741.57325840676, 2914.7959642825012, 2958.600588920511, 3001.4597372472945, 3059.969400305991, 3076.3385872037397, 952.380952380951, 1009.3237530854345, 1022.4274406332478, 1025.2310766924807, 1025.7025462615832, 10476.1095306899, 10564.049235568837, 10594.152467802558, 10621.362718236931, 10647.201459890463, 4124.896877578025, 4225.9577404225565, 4306.20335237982, 4306.956930430656, 4317.956820431818, 9038.141376569216, 9092.454452732858, 9098.044705305847, 9106.681266155652, 9134.132257435665, 4740.715557066587, 4745.383100197021, 4752.144613969519, 4755.881102972384, 4767.976160119178, 3726.720495962814, 4137.317342638491, 4223.535411104776, 4281.593248641374, 4340.544242854518, 3666.6333366663653, 3667.7982710951155, 3742.0831896185064, 3782.413725872494, 3885.941710874339, 1170.4791367841399, 1173.4426147580002, 1180.533689192764, 1180.557291015869, 1186.2348785033605, 806.161591944383, 831.3764676492631, 834.5451728807693, 839.886615306938, 860.8966923969164, 5030.84907452777, 5236.764345604457, 5268.578513718893, 5322.866928326745, 5364.409914909357, 408.0940312506231, 411.80027686571987, 416.3421793566158, 419.9160167966419, 421.3448088222843, 3262.9184270392957, 3263.1352691536763, 3283.737301015913, 3322.651121632242, 3331.1838599543266, 9205.723828285161, 9395.295352848563, 9403.106704863027, 9500.667476638284, 9512.28657850664, 9407.43555386679, 9409.952950235205, 9438.52807359643, 9467.195288400426, 9478.289128315266, 6967.442604591621, 7112.857742845217, 7217.458690598226, 7255.746048888158, 7267.418606511466, 4924.8276310328965, 4983.07813054586, 5030.245463180552, 5041.395032596112, 5055.16589762685, 8655.611430395993, 8754.562271886507, 8850.778730531789, 8883.555822208735, 8909.55452227399, 8784.516851573226, 8805.075467076122, 8959.41763785352, 9044.321675874467, 9065.093490651147, 6051.515878729603, 6666.300038496082, 6871.175458944958, 6890.345417185359, 6925.861482770417, 7570.735024274124, 7575.24247575238, 7622.733204337822, 7636.923630763844, 7682.961585192038, 6639.336066393322, 6823.420009299265, 6862.279460656759, 6896.965515172392, 6898.310168983062, 6677.198736151693, 6716.1604799400075, 6733.3939945405145, 6748.426383757435, 6907.827304317432, 6322.114903913548, 6327.145835312358, 6346.904796427965, 6416.807495775134, 6466.482681385572, 4390.3414487827085, 4398.648108151404, 4417.580329868657, 4424.225760491965, 4426.690131690751, 4326.783660817009, 4355.998120432381, 4378.715383500063, 4463.2635615123145, 4523.411956445641], "value": 4057.2166267281195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.8571871220526, 304.13928582112624, 305.97552195824335, 309.32258354204305, 310.29717689433437, 5100.31145795318, 5145.871353216172, 5162.741862906859, 5175.731945673306, 5258.6318957672975, 5117.616178786588, 5139.691618502883, 5144.356955380577, 5144.739538812996, 5182.481751824825, 3836.616338366155, 3914.432407300954, 4058.492688413948, 4075.7962101894936, 4082.9387559186634, 4049.6962727795385, 4049.7975101244965, 4063.5326937402283, 4064.4351924508983, 4070.715049946505, 4011.3982902564558, 4032.3145065338963, 4048.696347773914, 4049.473568436114, 4060.3810542200263, 3757.4927384802977, 4036.5963403659694, 4046.3930410438375, 4057.431959525669, 4062.9593704063172, 3447.482877568385, 3449.913752156191, 3452.3095380923914, 3455.844486998066, 3459.2043829919257, 5029.622778291606, 5031.572316353115, 5032.4212715537815, 5035.647504674675, 5059.139946209153, 4577.56513131252, 4587.655925805578, 4592.2193227151465, 4600.401947746805, 4606.216943119678, 5316.38861530925, 5378.784848606051, 5386.272853164812, 5395.514403703685, 5418.972905135489, 3773.584905660375, 3778.3199024175638, 3786.3752480840903, 3789.574672209788, 3811.656950874407, 5695.145728140812, 5731.767669950939, 5741.827745167651, 5764.221830052973, 5764.250647415809, 3769.3026790043928, 3847.633705271294, 3868.168343806095, 3877.495925529663, 3878.670313023368, 3876.437916502148, 3905.6680182184264, 3917.745346552465, 3930.862419815293, 3945.8027098644952, 4516.977415112903, 4538.092381523708, 4554.7039442436135, 4556.908861822745, 4566.817327306937, 5246.167069782351, 5435.646682965595, 5444.074507333763, 5473.029709304647, 5494.203340515603, 1342.5032737887045, 1360.5985834590388, 1366.549038817188, 1368.3363568669188, 1376.800363947222, 827.7185756842703, 856.7900864288165, 867.5141920524527, 872.616048938465, 877.1272583779053, 4564.307058835237, 4622.659428765687, 4787.808487660454, 4794.712317260975, 4797.328374027639, 5602.439756024446, 5611.887762244733, 5672.914906276326, 5684.863027394537, 5719.454842595089, 4600.7929643166135, 4785.473597904228, 4811.975940120347, 4815.30178124177, 4826.444958829709, 2969.6881827408242, 2974.7471464925293, 2975.3156773941682, 2985.567092771536, 3000.774941879324, 5263.078991159867, 5294.411676497036, 5307.734613269321, 5351.812686555952, 5361.544268737123, 5483.0, 5702.600817942787, 5748.252727145528, 5765.567582431335, 5779.508741756914, 5225.634205605647, 5235.712035838065, 5241.659292146074, 5253.500917412916, 5311.707856067954, 5622.803201887914, 5644.858878527905, 5651.4348565143155, 5654.208410822571, 5696.259486266925, 5278.2346559749385, 5482.506574408322, 5494.2582751329655, 5510.1459273812625, 5532.28080349552, 5224.738763061756, 5317.415084340642, 5336.839894803162, 5339.492748188916, 5358.062339090721, 3905.726599138033, 3940.4286378475535, 3958.287508248543, 3974.125692347679, 3978.6419222270133, 5397.703126327932, 5675.26221591207, 5686.800961966312, 5697.6296540724725, 5712.371639119777, 5513.8345849624575, 5531.838313953954, 5546.584006199632, 5553.0, 5574.358948720949, 5122.232829673757, 5484.2047903053035, 5485.451454854483, 5511.5669925818775, 5551.583631227593, 5365.865853353697, 5428.45715428454, 5441.26542916717, 5444.5916556259235, 5448.700321482356, 5269.868253293698, 5312.867178320573, 5466.91799622998, 5482.506574408322, 5532.474414930575, 5361.169018802092, 5431.185322201702, 5441.401445840876, 5454.372747133972, 5493.807716729895], "value": 4075.0003670501114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.7137687859536, 697.8429853283011, 723.2080871445766, 731.8792399254123, 744.8584768893907, 11640.417979101043, 13002.73994520109, 13511.121777084507, 13615.659608509792, 13668.316584170789, 13639.318034098305, 13706.520271790489, 13717.519886803964, 13743.587692369245, 13788.931055344734, 610.6244659534376, 787.1538096546221, 793.7261644732558, 793.7896457438783, 795.4352409789057, 773.0684525147212, 792.5244853088159, 794.4200733464575, 796.1361922314296, 798.1061211443192, 835.9164083591653, 843.8692002739555, 844.501743971057, 846.7713717296326, 847.3644766425181, 818.2553875972836, 827.664795757719, 827.8634025385804, 835.9665613375457, 836.9121242269565, 605.4036773777825, 607.419913982146, 608.2062907905182, 608.9847753806146, 609.9268087829445, 12714.237145771283, 12723.618291451272, 12753.553625623059, 12783.93608031954, 12993.155444896052, 12157.574484892986, 12300.200486968319, 12330.383480826013, 12455.626331210078, 13527.391267392892, 10282.434466104361, 10479.63321283759, 10632.627858024933, 10694.197935154816, 10705.25063245573, 3265.4611989021782, 3308.503724441329, 3324.4680851063713, 3327.184839714261, 3413.1467133216697, 62969.68515157395, 63450.682746585975, 63993.0, 64975.3502464974, 65018.674906625165, 10303.845442318372, 10420.531849103192, 10496.475176241158, 10642.521086551124, 10699.090577300862, 18997.43007709771, 19098.045097745056, 19107.426777196706, 19196.90401548011, 19198.8080119197, 6408.070829729756, 6540.738370465128, 6809.404363752194, 6820.147481564804, 7122.252163522756, 3694.649008344203, 3787.9431808522895, 3808.990617486368, 3830.0807806126327, 3854.3557393797237, 2999.355138645202, 3096.4735994880925, 3111.346617210366, 3114.9065528034193, 3117.6726443723537, 507.2973931105372, 525.0601423451978, 531.9175527793199, 534.8796520782793, 538.7979507684619, 478.55255336260706, 495.5490503641741, 510.40792680491194, 522.8091746512572, 523.2804893271751, 8087.150849160871, 8320.500769953822, 8320.625571849161, 8321.916780832114, 8414.537200454033, 565.2595100418465, 569.2770181869004, 578.2222910185793, 582.5514353947436, 583.585654185533, 3770.9434358484646, 3829.3681542545723, 3851.171998020439, 4111.0, 4282.721623094489, 96029.51985240029, 98201.0, 98636.0, 98843.50578247063, 99729.50135249278, 89822.0, 91841.54079229561, 91959.0, 92226.0, 92642.53678731564, 77713.0, 79953.60023199963, 80151.0, 81353.89845761473, 82673.58663206766, 8514.74455766328, 8546.78633034179, 8608.0, 8747.693830715894, 8752.0, 46272.30591541197, 46528.0, 47966.28050579174, 48144.51855481401, 48251.0, 59366.40633593609, 59821.70089149527, 66774.66612666905, 67315.0, 69022.30977690159, 11117.729398099915, 11231.326120432474, 11304.378259195822, 11395.487203075716, 11698.06415486742, 12499.0, 12511.374431278582, 12637.684057898627, 12940.870591294342, 12973.610791676265, 11587.0, 11699.88300116988, 11786.646400607995, 11957.701057473632, 12695.492180312684, 11509.136814739095, 11572.544570340648, 11618.593349232737, 11991.400429978641, 12313.322767247888, 10514.26400151982, 11174.944125279322, 11176.832347514632, 11385.943070284595, 11562.595309164139, 9981.0, 10146.847797282899, 10238.641647542301, 10286.845697314697, 10491.94754026225, 10127.594896204364, 10141.239407044353, 10265.538050787583, 10435.37387756737, 10488.370697758159], "value": 6659.318912971303, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 106.0, 115.0, 112.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 151.0, 161.0, 180.0, 135.0, 158.0, 157.0, 135.0, 195.0, 133.0], "value": 157.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 168.0, 172.0, 166.0, 164.0, 164.0, 165.0, 161.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 148.0, 76.0, 76.0, 76.0, 76.0, 165.0, 85.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 139.0, 85.0, 87.0, 88.0, 136.0, 88.0, 86.0, 141.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 147.0, 147.0, 148.0, 149.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 63.0, 71.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 86.0, 85.0, 84.0, 90.0, 89.0, 85.0, 98.0, 83.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 139.0, 133.0, 130.0, 132.0, 142.0, 133.0, 136.0, 132.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 163.0, 165.0, 170.0, 168.0, 168.0, 169.0, 165.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 71.0, 69.0, 66.0, 65.0, 67.0, 68.0, 66.0], "value": 67.5, "unit": "score"}]}]} 20:41:00 INFO - Return code: 0 20:41:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:41:00 ERROR - # TBPL SUCCESS # 20:41:00 INFO - Running post-action listener: _resource_record_post_action 20:41:00 INFO - ##### 20:41:00 INFO - ##### Finished run-tests step (success) 20:41:00 INFO - ##### 20:41:00 INFO - Running post-run listener: _resource_record_post_run 20:41:00 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 537821184; Read time: 424; Write time: 494976 20:41:00 INFO - TinderboxPrint: CPU usage
13.5% 20:41:00 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 424 20:41:00 INFO - TinderboxPrint: I/O write bytes / time
537,821,184 / 494,976 20:41:00 INFO - TinderboxPrint: CPU idle
8,265.7 (86.5%) 20:41:00 INFO - TinderboxPrint: CPU user
1,230.2 (12.9%) 20:41:00 INFO - TinderboxPrint: Swap in / out
0 / 0 20:41:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 245649408; Read time: 236; Write time: 262492 20:41:01 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291569664; Read time: 188; Write time: 232432 20:41:01 INFO - Running post-run listener: _upload_blobber_files 20:41:01 INFO - Blob upload gear active. 20:41:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:41:01 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 20:41:01 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:41:01 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:41:01 INFO - (blobuploader) - INFO - Open directory for files ... 20:41:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:41:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:03 INFO - (blobuploader) - INFO - Done attempting. 20:41:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:41:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:06 INFO - (blobuploader) - INFO - Done attempting. 20:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:07 INFO - (blobuploader) - INFO - Done attempting. 20:41:07 INFO - (blobuploader) - INFO - Iteration through files over. 20:41:07 INFO - Return code: 0 20:41:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:41:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:41:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6214b3d546373ea9ca6ea8c1816648ca32938af36a8d229203fc6148428c630ff3b67b617353390e01850bf77120281dea8b9f52a0dba41b4daa8b4b738a71be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb6087852367d070b90258105be7d08c6df4297a5d12fd71569067a6ab9b3989fd128e495955ffe9f0626e2b7743b8c7908ffe7248b6a1f414e17eec72ac3a79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3a33d7b2f5bd5e4f37ad902c08ebb2e60e1ec66bf7f238b5b639034781d07153682bda3440ba25bc9918af8cfe95c00c0b75e5c1bca2232d98c259b8158366ec"} 20:41:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:41:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:41:07 INFO - Contents: 20:41:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6214b3d546373ea9ca6ea8c1816648ca32938af36a8d229203fc6148428c630ff3b67b617353390e01850bf77120281dea8b9f52a0dba41b4daa8b4b738a71be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb6087852367d070b90258105be7d08c6df4297a5d12fd71569067a6ab9b3989fd128e495955ffe9f0626e2b7743b8c7908ffe7248b6a1f414e17eec72ac3a79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3a33d7b2f5bd5e4f37ad902c08ebb2e60e1ec66bf7f238b5b639034781d07153682bda3440ba25bc9918af8cfe95c00c0b75e5c1bca2232d98c259b8158366ec"} 20:41:07 INFO - Running post-run listener: copy_logs_to_upload_dir 20:41:07 INFO - Copying logs to upload dir... 20:41:07 INFO - mkdir: /builds/slave/test/build/upload/logs 20:41:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.080649 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-28 20:41:07.039442) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 20:41:07.042713) ========= 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=4300f881736b422476174874000001bc-1467169601.771539-1207476424 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/Autoland-Non-PGO/sha512/6214b3d546373ea9ca6ea8c1816648ca32938af36a8d229203fc6148428c630ff3b67b617353390e01850bf77120281dea8b9f52a0dba41b4daa8b4b738a71be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb6087852367d070b90258105be7d08c6df4297a5d12fd71569067a6ab9b3989fd128e495955ffe9f0626e2b7743b8c7908ffe7248b6a1f414e17eec72ac3a79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3a33d7b2f5bd5e4f37ad902c08ebb2e60e1ec66bf7f238b5b639034781d07153682bda3440ba25bc9918af8cfe95c00c0b75e5c1bca2232d98c259b8158366ec"} build_url:https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6214b3d546373ea9ca6ea8c1816648ca32938af36a8d229203fc6148428c630ff3b67b617353390e01850bf77120281dea8b9f52a0dba41b4daa8b4b738a71be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb6087852367d070b90258105be7d08c6df4297a5d12fd71569067a6ab9b3989fd128e495955ffe9f0626e2b7743b8c7908ffe7248b6a1f414e17eec72ac3a79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3a33d7b2f5bd5e4f37ad902c08ebb2e60e1ec66bf7f238b5b639034781d07153682bda3440ba25bc9918af8cfe95c00c0b75e5c1bca2232d98c259b8158366ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 20:41:07.068023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:41:07.068365) ========= 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=4300f881736b422476174874000001bc-1467169601.771539-1207476424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:41:07.153340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 20:41:07.153653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 20:41:07.153950) ========= ========= Total master_lag: 0.21 =========