builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1467708391.78 results: success (0) buildid: 20160704223714 builduid: b89403da10b34c669b1b1a7fe5d427a1 revision: 652fa69526ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:31.777076) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:31.777562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:31.777867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:31.793563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:31.793871) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 01:46:32-- 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% 222M=0s 2016-07-05 01:46:33 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:31.932759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:31.933096) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019884 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:31.982828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 01:46:31.983171) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 652fa69526ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 652fa69526ff --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=6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 01:46:33,147 Setting DEBUG logging. 2016-07-05 01:46:33,147 attempt 1/10 2016-07-05 01:46:33,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/652fa69526ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 01:46:33,728 unpacking tar archive at: fx-team-652fa69526ff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 01:46:33.348695) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:33.349026) ========= script_repo_revision: 652fa69526ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:33.349442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:33.349708) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 01:46:33.359796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-05 01:46:33.360104) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:46:34 INFO - MultiFileLogger online at 20160705 01:46:34 in /builds/slave/test 01:46:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:46:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:46:34 INFO - {'append_to_log': False, 01:46:34 INFO - 'base_work_dir': '/builds/slave/test', 01:46:34 INFO - 'blob_upload_branch': 'Fx-Team', 01:46:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:46:34 INFO - 'branch': 'Fx-Team', 01:46:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:46:34 INFO - 'config_files': ('talos/linux_config.py',), 01:46:34 INFO - 'default_actions': ('clobber', 01:46:34 INFO - 'read-buildbot-config', 01:46:34 INFO - 'download-and-extract', 01:46:34 INFO - 'populate-webroot', 01:46:34 INFO - 'create-virtualenv', 01:46:34 INFO - 'install', 01:46:34 INFO - 'run-tests'), 01:46:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:46:34 INFO - 'download_minidump_stackwalk': True, 01:46:34 INFO - 'download_symbols': 'ondemand', 01:46:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:46:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:46:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:46:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:46:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:46:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:46:34 INFO - 'installer_path': 'installer.exe', 01:46:34 INFO - 'log_level': 'info', 01:46:34 INFO - 'log_name': 'talos', 01:46:34 INFO - 'log_to_console': True, 01:46:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:46:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:46:34 INFO - 'opt_config_files': (), 01:46:34 INFO - 'pip_index': False, 01:46:34 INFO - 'sps_profile': False, 01:46:34 INFO - 'sps_profile_interval': 0, 01:46:34 INFO - 'suite': 'dromaeojs-e10s', 01:46:34 INFO - 'system_bits': '32', 01:46:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:46:34 INFO - 'title': 'talos-linux64-ix-023', 01:46:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:46:34 INFO - 'use_talos_json': True, 01:46:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:46:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:46:34 INFO - 'work_dir': 'build'} 01:46:34 INFO - ##### 01:46:34 INFO - ##### Running clobber step. 01:46:34 INFO - ##### 01:46:34 INFO - Running pre-action listener: _resource_record_pre_action 01:46:34 INFO - Running main action method: clobber 01:46:34 INFO - rmtree: /builds/slave/test/build 01:46:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:46:35 INFO - Running post-action listener: _resource_record_post_action 01:46:35 INFO - ##### 01:46:35 INFO - ##### Finished clobber step (success) 01:46:35 INFO - ##### 01:46:35 INFO - ##### 01:46:35 INFO - ##### Running read-buildbot-config step. 01:46:35 INFO - ##### 01:46:35 INFO - Running pre-action listener: _resource_record_pre_action 01:46:35 INFO - Running main action method: read_buildbot_config 01:46:35 INFO - Using buildbot properties: 01:46:35 INFO - { 01:46:35 INFO - "project": "", 01:46:35 INFO - "product": "firefox", 01:46:35 INFO - "script_repo_revision": "production", 01:46:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:46:35 INFO - "repository": "", 01:46:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:46:35 INFO - "buildid": "20160704223714", 01:46:35 INFO - "pgo_build": "True", 01:46:35 INFO - "basedir": "/builds/slave/test", 01:46:35 INFO - "buildnumber": 884, 01:46:35 INFO - "slavename": "talos-linux64-ix-023", 01:46:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:46:35 INFO - "platform": "ubuntu64_hw", 01:46:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:46:35 INFO - "branch": "fx-team", 01:46:35 INFO - "repo_path": "integration/fx-team", 01:46:35 INFO - "revision": "652fa69526ff", 01:46:35 INFO - "stage_platform": "linux64-pgo", 01:46:35 INFO - "builduid": "b89403da10b34c669b1b1a7fe5d427a1", 01:46:35 INFO - "slavebuilddir": "test" 01:46:35 INFO - } 01:46:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:46:35 INFO - Running post-action listener: _resource_record_post_action 01:46:35 INFO - ##### 01:46:35 INFO - ##### Finished read-buildbot-config step (success) 01:46:35 INFO - ##### 01:46:35 INFO - ##### 01:46:35 INFO - ##### Running download-and-extract step. 01:46:35 INFO - ##### 01:46:35 INFO - Running pre-action listener: _resource_record_pre_action 01:46:35 INFO - Running main action method: download_and_extract 01:46:35 INFO - mkdir: /builds/slave/test/build/tests 01:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:35 INFO - https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:35 INFO - Downloaded 1361 bytes. 01:46:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:35 INFO - Using the following test package requirements: 01:46:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:46:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:46:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'jsshell-linux-x86_64.zip'], 01:46:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:46:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:46:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:46:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:46:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:46:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:35 INFO - https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:36 INFO - Downloaded 24297728 bytes. 01:46: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'] 01:46: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 01:46:38 INFO - Return code: 0 01:46:38 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 01:46: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')]} 01:46:38 INFO - https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:39 INFO - Downloaded 24297728 bytes. 01:46:39 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'] 01:46:39 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 01:46:40 INFO - Return code: 0 01:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:40 INFO - https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:41 INFO - Downloaded 14403333 bytes. 01:46:41 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'] 01:46:41 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 01:46:41 INFO - Return code: 0 01:46:41 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')]} 01:46:41 INFO - https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RxUHogJASq281CixQdB_CA/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 01:46:43 INFO - Downloaded 60354613 bytes. 01:46:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:43 INFO - mkdir: /builds/slave/test/properties 01:46:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:46:43 INFO - Writing to file /builds/slave/test/properties/build_url 01:46:43 INFO - Contents: 01:46:43 INFO - build_url:https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:44 INFO - Running post-action listener: _resource_record_post_action 01:46:44 INFO - Running post-action listener: set_extra_try_arguments 01:46:44 INFO - ##### 01:46:44 INFO - ##### Finished download-and-extract step (success) 01:46:44 INFO - ##### 01:46:44 INFO - ##### 01:46:44 INFO - ##### Running populate-webroot step. 01:46:44 INFO - ##### 01:46:44 INFO - Running pre-action listener: _resource_record_pre_action 01:46:44 INFO - Running main action method: populate_webroot 01:46:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:46:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:46:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:46:44 INFO - '--tppagecycles', 01:46:44 INFO - '7'], 01:46:44 INFO - 'tests': ['tsvgm']}}, 01:46:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:46:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:46:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:46:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:46:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:44 INFO - 'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:44 INFO - 'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['damp', 'tps']}, 01:46:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:44 INFO - 'tests': ['damp', 'tps']}, 01:46:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['dromaeo_dom']}, 01:46:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:46:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['basic_compositor_video']}, 01:46:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:46:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['a11yr', 01:46:44 INFO - 'ts_paint', 01:46:44 INFO - 'tpaint', 01:46:44 INFO - 'sessionrestore', 01:46:44 INFO - 'sessionrestore_no_auto_restore', 01:46:44 INFO - 'tabpaint']}, 01:46:44 INFO - 'other-e10s': {'tests': ['a11yr', 01:46:44 INFO - 'ts_paint', 01:46:44 INFO - 'tpaint', 01:46:44 INFO - 'sessionrestore', 01:46:44 INFO - 'sessionrestore_no_auto_restore', 01:46:44 INFO - 'tabpaint']}, 01:46:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:46:44 INFO - 'ts_paint', 01:46:44 INFO - 'tpaint', 01:46:44 INFO - 'sessionrestore', 01:46:44 INFO - 'sessionrestore_no_auto_restore', 01:46:44 INFO - 'tabpaint']}, 01:46:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:46:44 INFO - 'ts_paint', 01:46:44 INFO - 'tpaint', 01:46:44 INFO - 'sessionrestore', 01:46:44 INFO - 'sessionrestore_no_auto_restore', 01:46:44 INFO - 'tabpaint']}, 01:46:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['a11yr', 01:46:44 INFO - 'ts_paint', 01:46:44 INFO - 'tpaint', 01:46:44 INFO - 'sessionrestore', 01:46:44 INFO - 'sessionrestore_no_auto_restore', 01:46:44 INFO - 'tabpaint']}, 01:46:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['a11yr', 01:46:44 INFO - 'ts_paint', 01:46:44 INFO - 'tpaint', 01:46:44 INFO - 'sessionrestore', 01:46:44 INFO - 'sessionrestore_no_auto_restore', 01:46:44 INFO - 'tabpaint']}, 01:46:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['tsvgx', 01:46:44 INFO - 'tsvgr_opacity', 01:46:44 INFO - 'tart', 01:46:44 INFO - 'tscrollx', 01:46:44 INFO - 'cart']}, 01:46:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:46:44 INFO - 'tsvgr_opacity', 01:46:44 INFO - 'tart', 01:46:44 INFO - 'tscrollx', 01:46:44 INFO - 'cart']}, 01:46:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:44 INFO - 'talos_options': ['--disable-e10s'], 01:46:44 INFO - 'tests': ['tp5o']}, 01:46:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:44 INFO - 'tests': ['tp5o']}, 01:46:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:44 INFO - 'talos_options': ['--disable-e10s', 01:46:44 INFO - '--xperf_path', 01:46:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:44 INFO - 'tests': ['tp5n']}, 01:46:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:44 INFO - 'talos_options': ['--xperf_path', 01:46:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:44 INFO - 'tests': ['tp5n']}}, 01:46:44 INFO - 'talos.zip': {'path': '', 01:46:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:46:44 INFO - Running post-action listener: _resource_record_post_action 01:46:44 INFO - ##### 01:46:44 INFO - ##### Finished populate-webroot step (success) 01:46:44 INFO - ##### 01:46:44 INFO - ##### 01:46:44 INFO - ##### Running create-virtualenv step. 01:46:44 INFO - ##### 01:46:44 INFO - Running pre-action listener: _resource_record_pre_action 01:46:44 INFO - Running main action method: create_virtualenv 01:46:44 INFO - Creating virtualenv /builds/slave/test/build/venv 01:46:44 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 01:46:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:46:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:46:44 INFO - Using real prefix '/usr' 01:46:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:46:44 INFO - Installing distribute.............................................................................................................................................................................................done. 01:46:46 INFO - Installing pip.................done. 01:46:46 INFO - Return code: 0 01:46:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:46: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')]} 01:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:46: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', 'pip>=1.5'] in /builds/slave/test/build 01:46: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 pip>=1.5 01:46:46 INFO - Using env: {'DISPLAY': ':0', 01:46:46 INFO - 'HOME': '/home/cltbld', 01:46:46 INFO - 'LANG': 'en_US.UTF-8', 01:46:46 INFO - 'LANGUAGE': 'en_US:en', 01:46:46 INFO - 'LOGNAME': 'cltbld', 01:46:46 INFO - 'MAIL': '/var/mail/cltbld', 01:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:46 INFO - 'MOZ_NO_REMOTE': '1', 01:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:46 INFO - 'NO_EM_RESTART': '1', 01:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:46 INFO - 'PWD': '/builds/slave/test', 01:46:46 INFO - 'SHELL': '/bin/bash', 01:46:46 INFO - 'SHLVL': '1', 01:46:46 INFO - 'TERM': 'linux', 01:46:46 INFO - 'TMOUT': '86400', 01:46:46 INFO - 'USER': 'cltbld', 01:46:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:46 INFO - '_': '/tools/buildbot/bin/python'} 01:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:46 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 01:46:46 INFO - Cleaning up... 01:46:47 INFO - Return code: 0 01:46:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:47 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:46:47 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 01:46:47 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 01:46:47 INFO - Using env: {'DISPLAY': ':0', 01:46:47 INFO - 'HOME': '/home/cltbld', 01:46:47 INFO - 'LANG': 'en_US.UTF-8', 01:46:47 INFO - 'LANGUAGE': 'en_US:en', 01:46:47 INFO - 'LOGNAME': 'cltbld', 01:46:47 INFO - 'MAIL': '/var/mail/cltbld', 01:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:47 INFO - 'MOZ_NO_REMOTE': '1', 01:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:47 INFO - 'NO_EM_RESTART': '1', 01:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:47 INFO - 'PWD': '/builds/slave/test', 01:46:47 INFO - 'SHELL': '/bin/bash', 01:46:47 INFO - 'SHLVL': '1', 01:46:47 INFO - 'TERM': 'linux', 01:46:47 INFO - 'TMOUT': '86400', 01:46:47 INFO - 'USER': 'cltbld', 01:46:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:47 INFO - '_': '/tools/buildbot/bin/python'} 01:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:47 INFO - Downloading/unpacking psutil>=3.1.1 01:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:46:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:49 INFO - Installing collected packages: psutil 01:46:49 INFO - Running setup.py install for psutil 01:46:49 INFO - building 'psutil._psutil_linux' extension 01:46:49 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 01:46:49 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 01:46:49 INFO - building 'psutil._psutil_posix' extension 01:46:49 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 01:46:49 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 01:46:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:49 INFO - Successfully installed psutil 01:46:49 INFO - Cleaning up... 01:46:49 INFO - Return code: 0 01:46:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:46:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:46:49 INFO - Using env: {'DISPLAY': ':0', 01:46:49 INFO - 'HOME': '/home/cltbld', 01:46:49 INFO - 'LANG': 'en_US.UTF-8', 01:46:49 INFO - 'LANGUAGE': 'en_US:en', 01:46:49 INFO - 'LOGNAME': 'cltbld', 01:46:49 INFO - 'MAIL': '/var/mail/cltbld', 01:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:49 INFO - 'MOZ_NO_REMOTE': '1', 01:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:49 INFO - 'NO_EM_RESTART': '1', 01:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:49 INFO - 'PWD': '/builds/slave/test', 01:46:49 INFO - 'SHELL': '/bin/bash', 01:46:49 INFO - 'SHLVL': '1', 01:46:49 INFO - 'TERM': 'linux', 01:46:49 INFO - 'TMOUT': '86400', 01:46:49 INFO - 'USER': 'cltbld', 01:46:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:49 INFO - '_': '/tools/buildbot/bin/python'} 01:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:46:51 INFO - Installing collected packages: mozsystemmonitor 01:46:51 INFO - Running setup.py install for mozsystemmonitor 01:46:51 INFO - Successfully installed mozsystemmonitor 01:46:51 INFO - Cleaning up... 01:46:52 INFO - Return code: 0 01:46:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:52 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:46:52 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 01:46:52 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 01:46:52 INFO - Using env: {'DISPLAY': ':0', 01:46:52 INFO - 'HOME': '/home/cltbld', 01:46:52 INFO - 'LANG': 'en_US.UTF-8', 01:46:52 INFO - 'LANGUAGE': 'en_US:en', 01:46:52 INFO - 'LOGNAME': 'cltbld', 01:46:52 INFO - 'MAIL': '/var/mail/cltbld', 01:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:52 INFO - 'MOZ_NO_REMOTE': '1', 01:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:52 INFO - 'NO_EM_RESTART': '1', 01:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:52 INFO - 'PWD': '/builds/slave/test', 01:46:52 INFO - 'SHELL': '/bin/bash', 01:46:52 INFO - 'SHLVL': '1', 01:46:52 INFO - 'TERM': 'linux', 01:46:52 INFO - 'TMOUT': '86400', 01:46:52 INFO - 'USER': 'cltbld', 01:46:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:52 INFO - '_': '/tools/buildbot/bin/python'} 01:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:52 INFO - Downloading/unpacking jsonschema==2.5.1 01:46:52 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 01:46:52 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 01:46:52 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 01:46:52 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 01:46:52 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 01:46:52 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 01:46:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:46:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:54 INFO - Downloading functools32-3.2.3-2.tar.gz 01:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:46:54 INFO - warning: no files found matching '*.txt' 01:46:54 INFO - no previously-included directories found matching 'build' 01:46:54 INFO - no previously-included directories found matching 'dist' 01:46:54 INFO - no previously-included directories found matching '.git*' 01:46:54 INFO - Installing collected packages: jsonschema, functools32 01:46:54 INFO - Running setup.py install for functools32 01:46:54 INFO - warning: no files found matching '*.txt' 01:46:54 INFO - no previously-included directories found matching 'build' 01:46:54 INFO - no previously-included directories found matching 'dist' 01:46:54 INFO - no previously-included directories found matching '.git*' 01:46:54 INFO - Successfully installed jsonschema functools32 01:46:54 INFO - Cleaning up... 01:46:54 INFO - Return code: 0 01:46:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:54 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:46:54 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 01:46:54 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 01:46:54 INFO - Using env: {'DISPLAY': ':0', 01:46:54 INFO - 'HOME': '/home/cltbld', 01:46:54 INFO - 'LANG': 'en_US.UTF-8', 01:46:54 INFO - 'LANGUAGE': 'en_US:en', 01:46:54 INFO - 'LOGNAME': 'cltbld', 01:46:54 INFO - 'MAIL': '/var/mail/cltbld', 01:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:54 INFO - 'MOZ_NO_REMOTE': '1', 01:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:54 INFO - 'NO_EM_RESTART': '1', 01:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:54 INFO - 'PWD': '/builds/slave/test', 01:46:54 INFO - 'SHELL': '/bin/bash', 01:46:54 INFO - 'SHLVL': '1', 01:46:54 INFO - 'TERM': 'linux', 01:46:54 INFO - 'TMOUT': '86400', 01:46:54 INFO - 'USER': 'cltbld', 01:46:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:54 INFO - '_': '/tools/buildbot/bin/python'} 01:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:54 INFO - Downloading/unpacking blobuploader==1.2.4 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:56 INFO - Downloading blobuploader-1.2.4.tar.gz 01:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:46:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:46:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:46:57 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 01:46:57 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 01:46:57 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 01:46:57 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 01:46:57 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 01:46:57 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 01:46:57 INFO - Downloading docopt-0.6.1.tar.gz 01:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:46:57 INFO - Installing collected packages: blobuploader, requests, docopt 01:46:57 INFO - Running setup.py install for blobuploader 01:46:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:46:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:46:57 INFO - Running setup.py install for requests 01:46:57 INFO - Running setup.py install for docopt 01:46:58 INFO - Successfully installed blobuploader requests docopt 01:46:58 INFO - Cleaning up... 01:46:58 INFO - Return code: 0 01:46:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46: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')]} 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:58 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:46:58 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 01:46:58 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 01:46:58 INFO - Using env: {'DISPLAY': ':0', 01:46:58 INFO - 'HOME': '/home/cltbld', 01:46:58 INFO - 'LANG': 'en_US.UTF-8', 01:46:58 INFO - 'LANGUAGE': 'en_US:en', 01:46:58 INFO - 'LOGNAME': 'cltbld', 01:46:58 INFO - 'MAIL': '/var/mail/cltbld', 01:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:58 INFO - 'MOZ_NO_REMOTE': '1', 01:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:58 INFO - 'NO_EM_RESTART': '1', 01:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:58 INFO - 'PWD': '/builds/slave/test', 01:46:58 INFO - 'SHELL': '/bin/bash', 01:46:58 INFO - 'SHLVL': '1', 01:46:58 INFO - 'TERM': 'linux', 01:46:58 INFO - 'TMOUT': '86400', 01:46:58 INFO - 'USER': 'cltbld', 01:46:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:58 INFO - '_': '/tools/buildbot/bin/python'} 01:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:46:58 INFO - Running setup.py (path:/tmp/pip-1878wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:46:58 INFO - Running setup.py (path:/tmp/pip-088Fg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:46:58 INFO - Running setup.py (path:/tmp/pip-yS2mf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:46:58 INFO - Running setup.py (path:/tmp/pip-c2lmb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:46:58 INFO - Running setup.py (path:/tmp/pip-L2fRNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:46:58 INFO - Running setup.py (path:/tmp/pip-nhM_zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:46:58 INFO - Running setup.py (path:/tmp/pip-Bs22L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:46:58 INFO - Running setup.py (path:/tmp/pip-HGFc3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:46:58 INFO - Running setup.py (path:/tmp/pip-JR9mHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:46:59 INFO - Running setup.py (path:/tmp/pip-_Ye69G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:46:59 INFO - Running setup.py (path:/tmp/pip-RRoTv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:46:59 INFO - Running setup.py (path:/tmp/pip-3VlM8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:46:59 INFO - Running setup.py (path:/tmp/pip-Eig32m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:46:59 INFO - Running setup.py (path:/tmp/pip-V3InHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:59 INFO - Running setup.py (path:/tmp/pip-HTFKLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:46:59 INFO - Running setup.py (path:/tmp/pip-mKDDRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:46:59 INFO - Running setup.py (path:/tmp/pip-fzieP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:46:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:46:59 INFO - Running setup.py install for manifestparser 01:46:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:46:59 INFO - Running setup.py install for mozcrash 01:46:59 INFO - Running setup.py install for mozdebug 01:46:59 INFO - Running setup.py install for mozdevice 01:47:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Running setup.py install for mozfile 01:47:00 INFO - Running setup.py install for mozhttpd 01:47:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Running setup.py install for mozinfo 01:47:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Running setup.py install for mozInstall 01:47:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Running setup.py install for mozleak 01:47:00 INFO - Running setup.py install for mozlog 01:47:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Running setup.py install for moznetwork 01:47:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Running setup.py install for mozprocess 01:47:00 INFO - Running setup.py install for mozprofile 01:47:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:47:00 INFO - Running setup.py install for mozrunner 01:47:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Running setup.py install for mozscreenshot 01:47:01 INFO - Running setup.py install for moztest 01:47:01 INFO - Running setup.py install for mozversion 01:47:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:47:01 INFO - Cleaning up... 01:47:01 INFO - Return code: 0 01:47:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:01 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:47:01 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 01:47:01 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 01:47:01 INFO - Using env: {'DISPLAY': ':0', 01:47:01 INFO - 'HOME': '/home/cltbld', 01:47:01 INFO - 'LANG': 'en_US.UTF-8', 01:47:01 INFO - 'LANGUAGE': 'en_US:en', 01:47:01 INFO - 'LOGNAME': 'cltbld', 01:47:01 INFO - 'MAIL': '/var/mail/cltbld', 01:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:01 INFO - 'MOZ_NO_REMOTE': '1', 01:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:01 INFO - 'NO_EM_RESTART': '1', 01:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:01 INFO - 'PWD': '/builds/slave/test', 01:47:01 INFO - 'SHELL': '/bin/bash', 01:47:01 INFO - 'SHLVL': '1', 01:47:01 INFO - 'TERM': 'linux', 01:47:01 INFO - 'TMOUT': '86400', 01:47:01 INFO - 'USER': 'cltbld', 01:47:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:01 INFO - '_': '/tools/buildbot/bin/python'} 01:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:01 INFO - Running setup.py (path:/tmp/pip-1fnz35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:01 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)) 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:01 INFO - Running setup.py (path:/tmp/pip-Vh8wMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:01 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)) 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:01 INFO - Running setup.py (path:/tmp/pip-w3VEsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:01 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)) 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:01 INFO - Running setup.py (path:/tmp/pip-FjKKBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:01 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)) 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:01 INFO - Running setup.py (path:/tmp/pip-qZ5BdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:01 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)) 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:01 INFO - Running setup.py (path:/tmp/pip-74XTsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:02 INFO - Running setup.py (path:/tmp/pip-Tm1uI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:02 INFO - Running setup.py (path:/tmp/pip-yM70_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:02 INFO - Running setup.py (path:/tmp/pip-lJ0EId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:02 INFO - Running setup.py (path:/tmp/pip-BemNvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:02 INFO - Running setup.py (path:/tmp/pip-6GzuEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:02 INFO - Running setup.py (path:/tmp/pip-YKxt0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:02 INFO - Running setup.py (path:/tmp/pip-p5T7ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:02 INFO - Running setup.py (path:/tmp/pip-jCLSEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:02 INFO - Running setup.py (path:/tmp/pip-aq3lik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:02 INFO - Running setup.py (path:/tmp/pip-p69YRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:02 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)) 01:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:02 INFO - Running setup.py (path:/tmp/pip-JHp5kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:02 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)) 01:47:02 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)) 01:47:02 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)) 01:47:02 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)) 01:47:02 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)) 01:47:02 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)) 01:47:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:04 INFO - Downloading blessings-1.6.tar.gz 01:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:47:04 INFO - Installing collected packages: blessings 01:47:04 INFO - Running setup.py install for blessings 01:47:04 INFO - Successfully installed blessings 01:47:04 INFO - Cleaning up... 01:47:05 INFO - Return code: 0 01:47:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:47:05 INFO - Reading from file tmpfile_stdout 01:47:05 INFO - Current package versions: 01:47:05 INFO - argparse == 1.2.1 01:47:05 INFO - blessings == 1.6 01:47:05 INFO - blobuploader == 1.2.4 01:47:05 INFO - docopt == 0.6.1 01:47:05 INFO - functools32 == 3.2.3-2 01:47:05 INFO - jsonschema == 2.5.1 01:47:05 INFO - manifestparser == 1.1 01:47:05 INFO - mozInstall == 1.12 01:47:05 INFO - mozcrash == 0.17 01:47:05 INFO - mozdebug == 0.1 01:47:05 INFO - mozdevice == 0.48 01:47:05 INFO - mozfile == 1.2 01:47:05 INFO - mozhttpd == 0.7 01:47:05 INFO - mozinfo == 0.9 01:47:05 INFO - mozleak == 0.1 01:47:05 INFO - mozlog == 3.2 01:47:05 INFO - moznetwork == 0.27 01:47:05 INFO - mozprocess == 0.22 01:47:05 INFO - mozprofile == 0.28 01:47:05 INFO - mozrunner == 6.11 01:47:05 INFO - mozscreenshot == 0.1 01:47:05 INFO - mozsystemmonitor == 0.3 01:47:05 INFO - moztest == 0.7 01:47:05 INFO - mozversion == 1.4 01:47:05 INFO - psutil == 3.1.1 01:47:05 INFO - requests == 1.2.3 01:47:05 INFO - wsgiref == 0.1.2 01:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:05 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')]} 01:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:05 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')]} 01:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:05 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:47:05 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 01:47:05 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 01:47:05 INFO - Using env: {'DISPLAY': ':0', 01:47:05 INFO - 'HOME': '/home/cltbld', 01:47:05 INFO - 'LANG': 'en_US.UTF-8', 01:47:05 INFO - 'LANGUAGE': 'en_US:en', 01:47:05 INFO - 'LOGNAME': 'cltbld', 01:47:05 INFO - 'MAIL': '/var/mail/cltbld', 01:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:05 INFO - 'MOZ_NO_REMOTE': '1', 01:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:05 INFO - 'NO_EM_RESTART': '1', 01:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:05 INFO - 'PWD': '/builds/slave/test', 01:47:05 INFO - 'SHELL': '/bin/bash', 01:47:05 INFO - 'SHLVL': '1', 01:47:05 INFO - 'TERM': 'linux', 01:47:05 INFO - 'TMOUT': '86400', 01:47:05 INFO - 'USER': 'cltbld', 01:47:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:05 INFO - '_': '/tools/buildbot/bin/python'} 01:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 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)) 01:47:05 INFO - Cleaning up... 01:47:05 INFO - Return code: 0 01:47:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:47:05 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')]} 01:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:05 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')]} 01:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:05 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 0x1a3e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cff180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', '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 01:47:05 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 01:47:05 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 01:47:05 INFO - Using env: {'DISPLAY': ':0', 01:47:05 INFO - 'HOME': '/home/cltbld', 01:47:05 INFO - 'LANG': 'en_US.UTF-8', 01:47:05 INFO - 'LANGUAGE': 'en_US:en', 01:47:05 INFO - 'LOGNAME': 'cltbld', 01:47:05 INFO - 'MAIL': '/var/mail/cltbld', 01:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:05 INFO - 'MOZ_NO_REMOTE': '1', 01:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:05 INFO - 'NO_EM_RESTART': '1', 01:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:05 INFO - 'PWD': '/builds/slave/test', 01:47:05 INFO - 'SHELL': '/bin/bash', 01:47:05 INFO - 'SHLVL': '1', 01:47:05 INFO - 'TERM': 'linux', 01:47:05 INFO - 'TMOUT': '86400', 01:47:05 INFO - 'USER': 'cltbld', 01:47:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:05 INFO - '_': '/tools/buildbot/bin/python'} 01:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:47:05 INFO - Cleaning up... 01:47:05 INFO - Return code: 0 01:47:05 INFO - Running post-action listener: _resource_record_post_action 01:47:05 INFO - Running post-action listener: _start_resource_monitoring 01:47:05 INFO - Starting resource monitoring. 01:47:05 INFO - ##### 01:47:05 INFO - ##### Finished create-virtualenv step (success) 01:47:05 INFO - ##### 01:47:05 INFO - ##### 01:47:05 INFO - ##### Running install step. 01:47:05 INFO - ##### 01:47:05 INFO - Running pre-action listener: _resource_record_pre_action 01:47:05 INFO - Running main action method: install 01:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:47:05 INFO - Reading from file tmpfile_stdout 01:47:05 INFO - Detecting whether we're running mozinstall >=1.0... 01:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:47:05 INFO - Reading from file tmpfile_stdout 01:47:05 INFO - Output received: 01:47:05 INFO - Usage: mozinstall [options] installer 01:47:05 INFO - Options: 01:47:05 INFO - -h, --help show this help message and exit 01:47:05 INFO - -d DEST, --destination=DEST 01:47:05 INFO - Directory to install application into. [default: 01:47:05 INFO - "/builds/slave/test"] 01:47:05 INFO - --app=APP Application being installed. [default: firefox] 01:47:05 INFO - mkdir: /builds/slave/test/build/application 01:47:05 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'] 01:47:05 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 01:47:23 INFO - Reading from file tmpfile_stdout 01:47:23 INFO - Output received: 01:47:23 INFO - /builds/slave/test/build/application/firefox/firefox 01:47:23 INFO - Running post-action listener: _resource_record_post_action 01:47:23 INFO - ##### 01:47:23 INFO - ##### Finished install step (success) 01:47:23 INFO - ##### 01:47:23 INFO - ##### 01:47:23 INFO - ##### Running run-tests step. 01:47:23 INFO - ##### 01:47:23 INFO - Running pre-action listener: _resource_record_pre_action 01:47:23 INFO - Running main action method: run_tests 01:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:47:23 INFO - Python 2.7.3 01:47:23 INFO - Return code: 0 01:47:23 INFO - grabbing minidump binary from tooltool 01:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd3b0>, '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 0x1cfe2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:47:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:47:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:47:23 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 01:47:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:47:23 INFO - Return code: 0 01:47:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:47:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:47:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:47:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:47:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 01:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 01:47:23 INFO - Using env: {'DISPLAY': ':0', 01:47:23 INFO - 'HOME': '/home/cltbld', 01:47:23 INFO - 'LANG': 'en_US.UTF-8', 01:47:23 INFO - 'LANGUAGE': 'en_US:en', 01:47:23 INFO - 'LOGNAME': 'cltbld', 01:47:23 INFO - 'MAIL': '/var/mail/cltbld', 01:47:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:47:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:23 INFO - 'MOZ_NO_REMOTE': '1', 01:47:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:23 INFO - 'NO_EM_RESTART': '1', 01:47:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:23 INFO - 'PWD': '/builds/slave/test', 01:47:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:47:23 INFO - 'SHELL': '/bin/bash', 01:47:23 INFO - 'SHLVL': '1', 01:47:23 INFO - 'TERM': 'linux', 01:47:23 INFO - 'TMOUT': '86400', 01:47:23 INFO - 'USER': 'cltbld', 01:47:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658', 01:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:23 INFO - '_': '/tools/buildbot/bin/python'} 01:47:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 01:47:23 INFO - mozversion application_buildid: 20160704223714 01:47:23 INFO - mozversion application_changeset: 652fa69526ff82afbe7b7e6a360709c457fddf19 01:47:23 INFO - mozversion application_display_name: Nightly 01:47:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:47:23 INFO - mozversion application_name: Firefox 01:47:23 INFO - mozversion application_remotingname: firefox 01:47:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:47:23 INFO - mozversion application_vendor: Mozilla 01:47:23 INFO - mozversion application_version: 50.0a1 01:47:23 INFO - mozversion platform_buildid: 20160704223714 01:47:23 INFO - mozversion platform_changeset: 652fa69526ff82afbe7b7e6a360709c457fddf19 01:47:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:47:23 INFO - mozversion platform_version: 50.0a1 01:47:23 INFO - using testdate: 1467708443 01:47:23 INFO - actual date: 1467708443 01:47:23 INFO - starting webserver on 'localhost:49246' 01:47:23 INFO - SUITE-START | Running 2 tests 01:47:23 INFO - TEST-START | dromaeo_css 01:47:23 INFO - operating with platform_type : linux_ 01:47:23 INFO - Initialising browser for dromaeo_css test... 01:47:23 INFO - TEST-INFO | started process 6644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD_PcGN/profile http://localhost:49246/getInfo.html) 01:47:27 INFO - PROCESS | 6644 | __metrics Screen width/height:1600/1200 01:47:27 INFO - PROCESS | 6644 | colorDepth:24 01:47:27 INFO - PROCESS | 6644 | Browser inner width/height: 1024/697 01:47:27 INFO - PROCESS | 6644 | __metrics 01:47:28 ERROR - PROCESS | 6644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:47:29 INFO - TEST-INFO | 6644: exit 0 01:47:29 INFO - Browser initialized. 01:47:29 INFO - Running cycle 1/1 for dromaeo_css test... 01:47:29 INFO - TEST-INFO | started process 6762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD_PcGN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:40 INFO - PROCESS | 6762 | RSS: Main: 168595456 01:47:40 INFO - PROCESS | 6762 | 01:48:30 INFO - PROCESS | 6762 | 1467708510490 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] 01:50:38 INFO - PROCESS | 6762 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 01:50:39 INFO - PROCESS | 6762 | RSS: Main: 171966464 01:50:39 INFO - PROCESS | 6762 | 01:53:42 INFO - PROCESS | 6762 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 01:53:42 INFO - PROCESS | 6762 | RSS: Main: 168828928 01:53:42 INFO - PROCESS | 6762 | 01:56:44 INFO - PROCESS | 6762 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 01:56:45 INFO - PROCESS | 6762 | RSS: Main: 172048384 01:56:45 INFO - PROCESS | 6762 | 01:59:46 INFO - PROCESS | 6762 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 01:59:47 INFO - PROCESS | 6762 | RSS: Main: 168361984 01:59:47 INFO - PROCESS | 6762 | 02:02:49 INFO - PROCESS | 6762 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 02:02:50 INFO - PROCESS | 6762 | RSS: Main: 169463808 02:02:50 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 02:05:53 INFO - PROCESS | 6762 | RSS: Main: 170315776 02:05:53 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | __start_tp_report 02:05:53 INFO - PROCESS | 6762 | _x_x_mozilla_page_load 02:05:53 INFO - PROCESS | 6762 | _x_x_mozilla_page_load_details 02:05:53 INFO - PROCESS | 6762 | |i|pagename|runs| 02:05:53 INFO - PROCESS | 6762 | |0;dojo.html;3101.3177101037772;3129.2959084206072;3169.2552250221192;3170.286685495763;3186.792858464201;5369.731513424328;5383.838484845451;5383.946160538393;5406.8377948661555;5417.404085550586;5275.762590683419;5410.702411367373;5423.945760542393;5437.619366644337;5470.5623550116;4895.11887860185;4918.2376731606655;5016.47327030662;5061.670991385567;5109.182530795074;4890.923996720733;5064.670796398241;5091.490850914897;5101.801076746961;5104.872378190556;4872.074305881889;4937.259411088366;4957.330760347343;4973.278874563186;4975.477574854643;4969.652124351297;4987.301777751118;4998.550130488274;5003.349564556621;5053.67151135175;4937.284093806378;4963.677360971561;4968.3292755477905;4969.180085285923;5009.273655319958;5226.503482169188;5374.650647707926;5379.811706590251;5428.4300148484235;5447.782088716486;5779.479846813765;5785.595008349417;5792.131180322943;5814.592978491507;5818.825435236908;5694.060480020791;5844.941550584483;5856.648601083906;5901.645901245896;5906.23218981534;5422.566194704415;5483.013057649621;5484.478974497416;5518.558515318765;5524.751386187671;6013.458788709037;6016.09758536223;6018.518518518596;6023.789167379121;6030.155778191057;5599.188117722907;5643.887122257532;5765;5776.162456443876;5787.536997040227;5763;5782.971085144547;5788.623739456922;5806.390329015477;5842.182094506772;5592.161175823659;5729.427057294237;5766.250387449689;5767.134929760486;5805.8548536286935;5696.743646535916;5735.655860648291;5798.9130163047585;5839.766409343663;5861.677607731615;4423.093265880487;4440.089781594766;4445.622122119656;4469.061497085649;4478.596926276651;3939.1530820873077;3941.034446560611;3942.48747662802;3947.388154836005;3982.143839074613;5371.033214021436;5418.566514678816;5422.15956526739;5603.411641777636;5645.661260324394;5682.460166284196;5715.31416230055;5717.028105222123;5717.885642287214;5785.27684039495;5429.755660995185;5471.781128754885;5476.780928762805;5480.972595136999;5488.25908502355;4984.22744474607;5014.34813474246;5038.899222015539;5083.339165908408;5083.517065878809;6029.216201893726;6087.756489740361;6098.32918378978;6116.847078823065;6122.846928826815;5927.407259274124;5932.911006334822;5933.821985340447;5937;5940.346561878104;5874;5945.91081133792;5962.314333851663;5993.340732519332;6017.939820601738;5688.829335119953;5693.060644993529;5707.886962042528;5715.657060576379;5727.968965586235;5682.090865461506;5775.682337471311;5827.358990510956;5839.708014599338;5841.240638716939;5466.398696143341;5573.860653483695;5626.718664066862;5650.802221922378;5706.172604972338;5674.404187560247;5695.829125126253;5705.22979397776;5710.029295019774;5724.169995350734;5630.324361076697;5643.971780141237;5644;5657.745401456862;5682.232898558807;5533;5656.943430565641;5704.942950570441;5754;5760.33756118035;5593.07714227148;5608.439156084359;5616.66300022;5628.352739435018;5629.915551266652 02:05:53 INFO - PROCESS | 6762 | |1;ext.html;573.7618888161411;615.9784407545735;620.4385031546452;623.2303105664504;634.2420807135474;37241.44137837931;42663.57336426635;42715.572844271584;42731.57268427319;42801.35797963033;41078.58921410785;41616.16767664645;41898.37152442708;41920.16159676805;41926.37110443338;8779.209871111614;8942.105789421072;8946.865797013017;8947.50788706621;8967.551622418885;8532;8558.78603034926;8600.139986001412;8624.35317351198;8631.093735157812;8820.338474614398;8853.42452740573;8860.24687901529;8874.600642971081;8883.333749968746;8461.450005749606;8507.787305317355;8543.700970466034;8560.14398560139;8605.655773769073;8814.294856411472;8824.426412283181;8837.425567338103;8854.335924805666;8892.199702026785;32897.177570560685;39805.60194398048;39936;40194.59805401967;40203.3969490455;3165.7625678074237;3303.520989456539;3343.1976325681903;3373.0724050885956;3492.109512074405;30742.692573074208;31076.223094422596;31325.216869578217;31403.37193256145;32044.359112817845;4227.387028880795;4236.6187043166265;4294.141171765659;4341.1100724351745;4349.717268377577;308471.4576427126;308479;308960;309100;310723;31456;33179.83410082982;34010.82994585011;34800.47799283013;35002.64997349994;35269;35588.28823423517;35604.82197588996;35929;35953.46069808955;15349.846501535065;15387.692246155015;15495.690086198212;15500.30248638814;15538.456154034555;12700.936495317465;12728;12746.617601471971;12769.936150319374;12794.104412691022;8183.6906095024515;8253.917460825314;8308.086110527836;8314.875276870851;8339.20777526134;3245.123816569513;3247.8213698246823;3269.0683155300626;3281.9179520511702;3300.785448945811;1048.7378155461136;1070.9410982395887;1078.417654466595;1087.0814162033068;1152.9077673786078;32441.675583244338;32762;32832.343353132805;33612;33843;1083.414955923808;1111.4220605285207;1124.5220781168134;1127.4193790198055;1155.930644161353;15221.923890380478;15372.769408458882;15464;15512.767308490382;15804.841951580336;260738;262916;262952;264147;507393;56514.434855651736;57174;57261;57322.42677573171;57385;1252.5177806544546;1333.2600406774334;1379.6275005748591;1385.8544852790515;1399.2234309957867;30054.24864378408;31266.37467250597;31374.442497611286;31532;32026.67973320237;48633.5136648629;49499.50500495093;49663.503364967335;49734;49759.751201243766;535986;538007;538705;541336;541721;27928.30179245535;27972.16083517498;28156.85921570461;28187.57718634263;28268.71731282743;46148.307775382724;46490.07019859651;47209.29186062143;47696.7615161922;48112;40404.59595404126;41169.794151029055;41176.58823411728;41364.379534306405;41616.3757543631;40296;40932.1813563733;41318.31430956978;41396.172076558905;41710;40228.79885600553;40625;41744;42071.15857682768;45090;34339.31321373609;36957.445638315985;37492.2501549962;37610.8119459401;38148;28706.856465718374;28752.993645222316;29241.707582924748;29299.414011720073;29363.706362936096 02:05:53 INFO - PROCESS | 6762 | |2;jquery.html;369.7485709717393;372.7912369073319;375.6243756243756;390.7089218532194;391.2507548045493;17684.911575442122;18190;18800.717989230172;18805.43583692488;18973.90513047433;10198.490075496233;10655.413952232624;10712.73218169546;10751.193660475457;10759.139268858493;4947.727874966884;4965.950340496603;4969.4036715594;5091.745412729368;5096.51583099605;4979.626528010395;5018.498150184989;5027.522385373383;5035.420926593433;5037.59699224063;5008.29883816266;5066.392032956051;5763.769449222026;5785.421457854223;5810.215620891189;5587.3015873015875;5758.280214973108;5765.654060756368;5780.132980052984;5809.128630705407;5154.840160963753;5187.610929180289;5213.843584692465;5228.372595288552;5248.501392367719;21207.15171393158;22337.776622233894;22618.66072008921;23652.053917843266;23664;2217.4899773052125;2246.2475070851283;2273.056681477185;2346.483773569812;2387.7731615496673;9205.447673139566;9422.575984080733;9474.099960503741;9498.762530936712;9547.761305967337;1901.3250296144945;1908.5896532245633;1941.4758015335922;1980.1287433529344;1980.722698822166;79858.20141798625;81503.18496815015;86256.56871715601;89717;90843.54578227132;10670.839937400946;10680.145588353069;10688.946555267174;11018.44907754609;11077.11383089351;14502.85497145036;14626.195559244345;14659.633509162357;14689.485867994568;14702.852971470362;7601.581912994728;8014.438989270695;8145.551994640352;8222.794430139294;8411.705590304433;8028.638711258008;8038.437309388287;8105.392095592854;8168.591570421455;8207.343412527103;4246.978765106216;4476;4598.724076555417;4803.567678908915;4805.13507568634;1848.5840685845847;1982.9504262393555;1983.5041239690077;1988.9403317900485;2012.6276638821864;900.1203131111668;916.2212119698337;984.5126662302206;985.7979114281555;1049.2550289294534;18883.433496995112;19759.901200494194;19792.90103549473;19934.80391176534;20189.596208075756;942.7548837302351;942.8915674697361;953.4231789767091;997.1225321716843;1033.204432586904;10633.73415664599;10756.300840445503;10785.245032847626;10785.83821242682;10989.06592939609;466060;470825.5834883283;471003;516343;521755;96665.51667241618;99215;99459.50270248602;100196;101942;1068.9198310126772;1074.666853275487;1079.3469950679882;1085.7719878825378;1086.4839201379282;17035.48893533196;17267.222974965905;17608.647827043642;17702.911485443004;18016;38418.615813841505;38543.614563854004;39241.215175696896;41739;43705.34441983309;56350;57265.427345726006;57993.420065798804;58191.709041454524;58334.4166558346;8193.959030204811;8296.419250652396;8324.084350721294;8437.282830959437;8812.64749410042;12907.741845162856;13239.139455935334;14172.858271417566;14176.362063706953;14674.266286685837;11733.413329333329;11886.930176284175;12217.45021474018;12395.31321490376;12552.686182845502;12091.153619246568;12260.019198463922;12350.81473777876;12369.319687417279;12371.69070773238;11391.088712902781;11445;11543.711407214887;11709.414529273672;12807.61577152687;7459.515131516434;7539.886901696369;7746.49647772893;8126.512409255463;8254.42219044661;8483.024452188078;12031.805713321699;12139.393030348623;12896.613101606967;13049.869501305246 02:05:53 INFO - PROCESS | 6762 | |3;mootools.html;1195.4022988505747;1247.8128280757885;1341.450005497746;1721.9139043047853;1724.5688577855535;7203.315685009916;8237.876431853527;8389.87415188772;8818.69134580289;8882.289416846654;8498.277646400047;8613.483191008543;8704.129587041292;8791.428557143781;8810.559472026405;2214.081156320129;2229.9108035678555;2242.7420846602604;2245.9101635934544;2253.7746225377496;2162.610730068587;2193.309107631099;2243.2036626997424;2244.057495851738;2251.2008237075847;2202.614542455064;2210.171185805323;2236.7427745809277;2250.707408036953;2277.646964720471;2221.6556433752794;2236.3738153317017;2236.4520692430297;2237.7762223777654;2238.742544607375;2175.5866385386726;2214.1254204589095;2216.2464761981005;2216.468047668564;2219.034719896834;8808.471491710454;8835.469871807712;8855.24730397917;8858.247049000842;8871.290296776242;4897.14299997499;5014.272930425068;5019.84940451787;5025.698458092526;5027.547520723152;3075.123589776903;3111.7043880831284;3162.810231386124;3207.342494788563;3218.227625369918;1083.7399024234205;1088.4992903264508;1099.1261946752352;1140.1790710688292;1141.8686851012158;12231.571894983634;12271.263724176488;12321.938390308082;12323.938380308042;12326.260424374477;4157.646600039031;4204.495460544693;4337.414449049401;4347.108842687305;4373.081652852873;10209;10224.335418197794;10229.94885025585;10262.538185781657;10286.074253317238;4971.602271818246;5016.122178618727;5058.8482345528955;5072.492750724972;5075.492450754895;3992.041909941593;4373.825046998148;4573.748443835554;4643.048175124159;4687.81248750053;3717.628237176261;3725.2735716535017;3831.942520862189;3831.9616803832164;3837.9616203838164;1174.6241202815017;1205.8673545909942;1213.5995121609847;1215.3619349841226;1236.5548402575066;830.779843341515;877.7366789962986;905.7690288976269;930.3534043839467;951.7525443384632;5464.754086066137;5593.692346920959;5610.635308705003;5754.079347304411;5768.2501274834;952.5856252530172;976.2385339435252;979.2215188924822;1008.3848852200152;1016.9949150254201;3819.2743378757946;3872.8644497442456;3908.6677632400997;3923.058465968147;3934.370500719871;10502.737431564272;11212.327260364404;11255.943720281346;11262.155338349656;11282.717932051764;10949.945250273857;11123.221374503708;11146.832797508045;11186.832197517044;11216.383098929637;8259.380546458919;8298.21166989147;8363.790905227297;8366.24703776663;8384.622691978875;5563.054280772198;5671.517920976763;5741.827745167651;5776.191333213437;5821.563382746226;10074.748131296483;10223;10317.48412579383;10359.378437293484;10371.118454931415;9743.80512389734;10079.34484258521;10474.109700675222;10512.842307365549;10578.047975682226;7017.2631873652535;7311.195768465571;7445.292697193758;7564.394848412004;7784.455088144002;8445.408821382443;8494.617742201739;8503.659853606034;8531.53076580794;8574.914250857411;7168.605726684874;7351.963240183765;7419.703211871465;7494.138174110047;7833.5691536966015;7520.172780993977;7566.31903128721;7846.058472983279;7868.803279918048;7897.723579674684;6804.82987925286;6886.24251332363;6904.654767261516;6930.099087118642;6960.512764106464;4863.829765958175;5093.261477085876;5115.18157094863;5140.408852981955;5228.9738551307;4977.9751101244265;5136.666116702402;5214.113600687816;5237.397699264633;5247.58019358458 02:05:53 INFO - PROCESS | 6762 | |4;prototype.html;290.3438229601102;294.2247178684168;296.38647998642807;298.634173137906;299.238438174845;5681.636407262264;5691.772329106836;5715.685637289947;5722.885542289152;5759.654420734759;5521.343596920928;5535.750891209896;5553.555715542757;5564.221009058725;5568.192612071247;4105.794710264489;4173.290540608089;4202.579742025803;4216.262154123032;4224.429701990238;4239.766812825309;4246.511651160125;4253.29820579604;4274.5939135782055;4276.486821581399;4246.97876510617;4257.276263035292;4259.723117997336;4260.1266740318315;4265.125649241898;3955.4660120883746;4131.566185550504;4141.751494910285;4153.937690934638;4260.552641972595;3511.894643160709;3513.84187711551;3523.40102182627;3524.2599054198395;3526.642242736565;5475.479829416199;5477.535109200836;5521.5306698930235;5544.6118771686;5560.805371812007;4554.908901821945;4750.12122757291;4770.379850619397;4777.163996300668;4798.304245884327;5860.238169038041;5861.560382971252;5864.677442740647;5891.911621325684;5938.851528711773;3930.449737036817;3940.7044471664453;3945.8495120159296;3950.9802450987563;3957.544882338539;6067.1202675611785;6067.393260673942;6092.756289748405;6094.329623741385;6208.87582248357;3992.6007399260425;4015.2170326785995;4016.738911970771;4018;4018.3771515415156;4096.672266218696;4100.236898133831;4105.486814148231;4118.052847845012;4125.257453658371;4681.133990211822;4807.110684523374;4825.4933232010835;4837.733924634179;4845;5886.381929897385;5904.76380944766;5910.335591932943;5915.048034148721;5952.226210592596;1408.3521580073282;1421.4740545998047;1421.7085497472992;1424.9572512824632;1425.4369524037947;883.5052370672444;891.772597987522;895.2122132523338;915.949622770754;948.0850978805486;5513.9448605514235;5563;5649.0114230009585;5673.659580425106;5701.144828275792;5900.6164599301765;5995.61028533144;6020.862593779233;6040.365761595057;6067.696615169224;5435.42927992563;5668.348139963874;5790.305163380422;5792.189093526909;5812.912806307909;3171.444997125494;3234.6118465784257;3259.152620318687;3288.3587700398193;3290.6709329066903;6188.752449902044;6290.370962903673;6339.017452294902;6390.53017805898;6422.325655806073;6222.657753823492;6231.9688401557705;6242.439390152462;6270.592411493239;6295.150154729145;6082.148499210114;6295.213098362705;6308.716107775161;6319.873602527924;6399.328070552618;6094.573379863545;6096.512279017757;6106.969465152646;6121.1430399743185;6121.173641558333;6023.27720673522;6024.87950240984;6044.516438684983;6048.183495228088;6130.295016073031;6031.638101713911;6207.720652570555;6356.904646430215;6399.424051835357;6414.647194404352;4186.581341865911;4193.496780386251;4199.916001680011;4208.684348673923;4217;5834.241548598655;6177;6202.4417802398;6212.347703491249;6223.128761973237;5867.149263356704;5889.381614930542;5897.823065308047;5943.613665111754;5961.7615295387695;5935.436133567304;5952.702364881825;5964.403559644001;5987.670678112746;6031.306399763907;5680.573956953328;5835.153902684172;5855.502282306052;5894.616849904743;5915.556333274935;5994.100884867305;6019.458248757458;6025.728842202024;6040.0939859019745;6054.727537260922;5609.186667933209;5868.679547101868;5873.706314684334;5914.349421563538;5926.422006427218 02:05:53 INFO - PROCESS | 6762 | |5;yui.html;678.8913773796194;684.9965750171249;701.1866235167206;735.4814855526854;810.6797814863131;13798.793018104736;14826.184559849204;14888.851111488882;15077.246137693126;15101;13548.322583870817;13870.722585548283;13950.162990220568;14572.198529080897;14750.852491475081;789.2817536042188;804.6861723927673;807.1887752808419;807.5800583696504;807.6042739057879;786.2805532937384;806.9354451643884;811.4968719393984;815.8776183572481;819.3690858039306;835.0855812884881;839.9454035487673;842.2125312832521;843.0768308701962;844.1010324004945;838.6729175621513;839.7102999465175;840.231188462556;840.9243168114868;841.6801615386145;608.0605464557269;609.3419107364081;609.9268087829445;613.2487702564367;613.6287546034674;13524.053316267866;13524.729505409936;13529.458821647122;13529.932350338186;13531.458741650322;14145;14427.691569348854;14853.108813471119;14876.70246595062;14903;10776.245662803607;10837.349759014485;11212.495437705242;11296.300915417409;11305.830412543819;3860.478835357247;3876.1472476055505;3906;3949.9012524686827;3951.980240098781;81074;81823.18176818216;81988.59005704934;82593;82865;11091.83362249567;11305.660830175108;11346.943265283786;11351.205415620827;11744.94127529374;20583.691244631344;20648.690269645966;20664.380068597966;20851.478713032295;20929.162833486793;8337.124601916832;8482.957585212034;8504;8551.957240213758;8634;4751.64362672801;4796.448408433005;4894.461609222983;4934.1118598651865;5062.038212739568;3322.8836990705695;3433.055909624873;3434.9141271467915;3440.518327434161;3444.0873168610337;561.5227057001516;573.8077743955738;578.6238944685988;579.3655946738314;585.1047896718028;649.2598437780933;732.542161149271;745.1840234942729;756.2210922749576;756.3042001358763;9856.704298871045;9879.209663226924;9960.904300526936;10059.195264378832;10177.287589868638;527.9208118782213;649.938255865692;695.2595485807599;711.5623891306913;742.2985278911485;4578.5421457853945;4722.598579120745;4770.255702000573;4806.110869489155;4864.433015429213;103620;121915;122058;122535.26056066823;125916.37041814733;105012.47493762482;105379;105533;106070;107496;54049;55080.17379739307;55847.16229256564;87808.5609571948;88300.55849720839;8818.91181088181;8823.250023748053;8836.072212417603;8850;8890.288776897962;54448.72775636255;54492.82028718807;54929.72535137299;55088.17367739567;56139.438605613424;74058.62970685112;75327;83051;84426;86814;11925.940370298093;11957.282563046245;12042.939785301018;12067;12647.620571382873;13094.541691040768;13868.861311386758;14025.298735063003;14101.506447274296;14347.856521434653;12703.93648031754;12931.5473958411;13285.003624728377;13404.293523801893;13425.462981480632;12714.745705085661;12822.23066616006;12909.935450322688;12977.961763058744;13169.47322107105;12099.879001209874;12535.435905384462;12748.936255319035;12781.552645657357;13032.47870085186;10380.896191037993;10876.891231087588;11144.60993865211;11160.330380177214;11389.373584452935;10592.470376481298;11241.437928103725;11758.764824703629;11805.70485737829;11879.821802672794 02:05:53 INFO - PROCESS | 6762 | __end_tp_report 02:05:53 INFO - PROCESS | 6762 | __start_cc_report 02:05:53 INFO - PROCESS | 6762 | _x_x_mozilla_cycle_collect,358 02:05:53 INFO - PROCESS | 6762 | __end_cc_report 02:05:53 INFO - PROCESS | 6762 | __startTimestamp1467709553614__endTimestamp 02:05:53 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | ------- Summary: start ------- 02:05:53 INFO - PROCESS | 6762 | Number of tests: 6 02:05:53 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | [#0] dojo.html Cycles:165 Average:5403.87 Median:5626.72 stddev:608.25 (10.8%) stddev-sans-first:582.68 02:05:53 INFO - PROCESS | 6762 | Values: 3101.3 3129.3 3169.3 3170.3 3186.8 5369.7 5383.8 5383.9 5406.8 5417.4 5275.8 5410.7 5423.9 5437.6 5470.6 4895.1 4918.2 5016.5 5061.7 5109.2 4890.9 5064.7 5091.5 5101.8 5104.9 4872.1 4937.3 4957.3 4973.3 4975.5 4969.7 4987.3 4998.6 5003.3 5053.7 4937.3 4963.7 4968.3 4969.2 5009.3 5226.5 5374.7 5379.8 5428.4 5447.8 5779.5 5785.6 5792.1 5814.6 5818.8 5694.1 5844.9 5856.6 5901.6 5906.2 5422.6 5483.0 5484.5 5518.6 5524.8 6013.5 6016.1 6018.5 6023.8 6030.2 5599.2 5643.9 5765.0 5776.2 5787.5 5763.0 5783.0 5788.6 5806.4 5842.2 5592.2 5729.4 5766.3 5767.1 5805.9 5696.7 5735.7 5798.9 5839.8 5861.7 4423.1 4440.1 4445.6 4469.1 4478.6 3939.2 3941.0 3942.5 3947.4 3982.1 5371.0 5418.6 5422.2 5603.4 5645.7 5682.5 5715.3 5717.0 5717.9 5785.3 5429.8 5471.8 5476.8 5481.0 5488.3 4984.2 5014.3 5038.9 5083.3 5083.5 6029.2 6087.8 6098.3 6116.8 6122.8 5927.4 5932.9 5933.8 5937.0 5940.3 5874.0 5945.9 5962.3 5993.3 6017.9 5688.8 5693.1 5707.9 5715.7 5728.0 5682.1 5775.7 5827.4 5839.7 5841.2 5466.4 5573.9 5626.7 5650.8 5706.2 5674.4 5695.8 5705.2 5710.0 5724.2 5630.3 5644.0 5644.0 5657.7 5682.2 5533.0 5656.9 5704.9 5754.0 5760.3 5593.1 5608.4 5616.7 5628.4 5629.9 02:05:53 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | [#1] ext.html Cycles:180 Average:53602.27 Median:38976.80 stddev:107948.67 (277.0%) stddev-sans-first:108178.07 02:05:53 INFO - PROCESS | 6762 | Values: 573.8 616.0 620.4 623.2 634.2 37241.4 42663.6 42715.6 42731.6 42801.4 41078.6 41616.2 41898.4 41920.2 41926.4 8779.2 8942.1 8946.9 8947.5 8967.6 8532.0 8558.8 8600.1 8624.4 8631.1 8820.3 8853.4 8860.2 8874.6 8883.3 8461.5 8507.8 8543.7 8560.1 8605.7 8814.3 8824.4 8837.4 8854.3 8892.2 32897.2 39805.6 39936.0 40194.6 40203.4 3165.8 3303.5 3343.2 3373.1 3492.1 30742.7 31076.2 31325.2 31403.4 32044.4 4227.4 4236.6 4294.1 4341.1 4349.7 308471.5 308479.0 308960.0 309100.0 310723.0 31456.0 33179.8 34010.8 34800.5 35002.6 35269.0 35588.3 35604.8 35929.0 35953.5 15349.8 15387.7 15495.7 15500.3 15538.5 12700.9 12728.0 12746.6 12769.9 12794.1 8183.7 8253.9 8308.1 8314.9 8339.2 3245.1 3247.8 3269.1 3281.9 3300.8 1048.7 1070.9 1078.4 1087.1 1152.9 32441.7 32762.0 32832.3 33612.0 33843.0 1083.4 1111.4 1124.5 1127.4 1155.9 15221.9 15372.8 15464.0 15512.8 15804.8 260738.0 262916.0 262952.0 264147.0 507393.0 56514.4 57174.0 57261.0 57322.4 57385.0 1252.5 1333.3 1379.6 1385.9 1399.2 30054.2 31266.4 31374.4 31532.0 32026.7 48633.5 49499.5 49663.5 49734.0 49759.8 535986.0 538007.0 538705.0 541336.0 541721.0 27928.3 27972.2 28156.9 28187.6 28268.7 46148.3 46490.1 47209.3 47696.8 48112.0 40404.6 41169.8 41176.6 41364.4 41616.4 40296.0 40932.2 41318.3 41396.2 41710.0 40228.8 40625.0 41744.0 42071.2 45090.0 34339.3 36957.4 37492.3 37610.8 38148.0 28706.9 28753.0 29241.7 29299.4 29363.7 02:05:53 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | [#2] jquery.html Cycles:180 Average:28940.80 Median:19397.12 stddev:81086.07 (418.0%) stddev-sans-first:81285.16 02:05:53 INFO - PROCESS | 6762 | Values: 369.7 372.8 375.6 390.7 391.3 17684.9 18190.0 18800.7 18805.4 18973.9 10198.5 10655.4 10712.7 10751.2 10759.1 4947.7 4966.0 4969.4 5091.7 5096.5 4979.6 5018.5 5027.5 5035.4 5037.6 5008.3 5066.4 5763.8 5785.4 5810.2 5587.3 5758.3 5765.7 5780.1 5809.1 5154.8 5187.6 5213.8 5228.4 5248.5 21207.2 22337.8 22618.7 23652.1 23664.0 2217.5 2246.2 2273.1 2346.5 2387.8 9205.4 9422.6 9474.1 9498.8 9547.8 1901.3 1908.6 1941.5 1980.1 1980.7 79858.2 81503.2 86256.6 89717.0 90843.5 10670.8 10680.1 10688.9 11018.4 11077.1 14502.9 14626.2 14659.6 14689.5 14702.9 7601.6 8014.4 8145.6 8222.8 8411.7 8028.6 8038.4 8105.4 8168.6 8207.3 4247.0 4476.0 4598.7 4803.6 4805.1 1848.6 1983.0 1983.5 1988.9 2012.6 900.1 916.2 984.5 985.8 1049.3 18883.4 19759.9 19792.9 19934.8 20189.6 942.8 942.9 953.4 997.1 1033.2 10633.7 10756.3 10785.2 10785.8 10989.1 466060.0 470825.6 471003.0 516343.0 521755.0 96665.5 99215.0 99459.5 100196.0 101942.0 1068.9 1074.7 1079.3 1085.8 1086.5 17035.5 17267.2 17608.6 17702.9 18016.0 38418.6 38543.6 39241.2 41739.0 43705.3 56350.0 57265.4 57993.4 58191.7 58334.4 8194.0 8296.4 8324.1 8437.3 8812.6 12907.7 13239.1 14172.9 14176.4 14674.3 11733.4 11886.9 12217.5 12395.3 12552.7 12091.2 12260.0 12350.8 12369.3 12371.7 11391.1 11445.0 11543.7 11709.4 12807.6 7459.5 7539.9 7746.5 8126.5 8254.4 8483.0 12031.8 12139.4 12896.6 13049.9 02:05:53 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | [#3] mootools.html Cycles:180 Average:5708.54 Median:4360.10 stddev:3346.94 (76.8%) stddev-sans-first:3339.15 02:05:53 INFO - PROCESS | 6762 | Values: 1195.4 1247.8 1341.5 1721.9 1724.6 7203.3 8237.9 8389.9 8818.7 8882.3 8498.3 8613.5 8704.1 8791.4 8810.6 2214.1 2229.9 2242.7 2245.9 2253.8 2162.6 2193.3 2243.2 2244.1 2251.2 2202.6 2210.2 2236.7 2250.7 2277.6 2221.7 2236.4 2236.5 2237.8 2238.7 2175.6 2214.1 2216.2 2216.5 2219.0 8808.5 8835.5 8855.2 8858.2 8871.3 4897.1 5014.3 5019.8 5025.7 5027.5 3075.1 3111.7 3162.8 3207.3 3218.2 1083.7 1088.5 1099.1 1140.2 1141.9 12231.6 12271.3 12321.9 12323.9 12326.3 4157.6 4204.5 4337.4 4347.1 4373.1 10209.0 10224.3 10229.9 10262.5 10286.1 4971.6 5016.1 5058.8 5072.5 5075.5 3992.0 4373.8 4573.7 4643.0 4687.8 3717.6 3725.3 3831.9 3832.0 3838.0 1174.6 1205.9 1213.6 1215.4 1236.6 830.8 877.7 905.8 930.4 951.8 5464.8 5593.7 5610.6 5754.1 5768.3 952.6 976.2 979.2 1008.4 1017.0 3819.3 3872.9 3908.7 3923.1 3934.4 10502.7 11212.3 11255.9 11262.2 11282.7 10949.9 11123.2 11146.8 11186.8 11216.4 8259.4 8298.2 8363.8 8366.2 8384.6 5563.1 5671.5 5741.8 5776.2 5821.6 10074.7 10223.0 10317.5 10359.4 10371.1 9743.8 10079.3 10474.1 10512.8 10578.0 7017.3 7311.2 7445.3 7564.4 7784.5 8445.4 8494.6 8503.7 8531.5 8574.9 7168.6 7352.0 7419.7 7494.1 7833.6 7520.2 7566.3 7846.1 7868.8 7897.7 6804.8 6886.2 6904.7 6930.1 6960.5 4863.8 5093.3 5115.2 5140.4 5229.0 4978.0 5136.7 5214.1 5237.4 5247.6 02:05:53 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | [#4] prototype.html Cycles:180 Average:4917.98 Median:5708.42 stddev:1525.25 (26.7%) stddev-sans-first:1489.46 02:05:53 INFO - PROCESS | 6762 | Values: 290.3 294.2 296.4 298.6 299.2 5681.6 5691.8 5715.7 5722.9 5759.7 5521.3 5535.8 5553.6 5564.2 5568.2 4105.8 4173.3 4202.6 4216.3 4224.4 4239.8 4246.5 4253.3 4274.6 4276.5 4247.0 4257.3 4259.7 4260.1 4265.1 3955.5 4131.6 4141.8 4153.9 4260.6 3511.9 3513.8 3523.4 3524.3 3526.6 5475.5 5477.5 5521.5 5544.6 5560.8 4554.9 4750.1 4770.4 4777.2 4798.3 5860.2 5861.6 5864.7 5891.9 5938.9 3930.4 3940.7 3945.8 3951.0 3957.5 6067.1 6067.4 6092.8 6094.3 6208.9 3992.6 4015.2 4016.7 4018.0 4018.4 4096.7 4100.2 4105.5 4118.1 4125.3 4681.1 4807.1 4825.5 4837.7 4845.0 5886.4 5904.8 5910.3 5915.0 5952.2 1408.4 1421.5 1421.7 1425.0 1425.4 883.5 891.8 895.2 915.9 948.1 5513.9 5563.0 5649.0 5673.7 5701.1 5900.6 5995.6 6020.9 6040.4 6067.7 5435.4 5668.3 5790.3 5792.2 5812.9 3171.4 3234.6 3259.2 3288.4 3290.7 6188.8 6290.4 6339.0 6390.5 6422.3 6222.7 6232.0 6242.4 6270.6 6295.2 6082.1 6295.2 6308.7 6319.9 6399.3 6094.6 6096.5 6107.0 6121.1 6121.2 6023.3 6024.9 6044.5 6048.2 6130.3 6031.6 6207.7 6356.9 6399.4 6414.6 4186.6 4193.5 4199.9 4208.7 4217.0 5834.2 6177.0 6202.4 6212.3 6223.1 5867.1 5889.4 5897.8 5943.6 5961.8 5935.4 5952.7 5964.4 5987.7 6031.3 5680.6 5835.2 5855.5 5894.6 5915.6 5994.1 6019.5 6025.7 6040.1 6054.7 5609.2 5868.7 5873.7 5914.3 5926.4 02:05:53 INFO - PROCESS | 6762 | 02:05:53 INFO - PROCESS | 6762 | [#5] yui.html Cycles:180 Average:20817.79 Median:3950.94 stddev:30830.65 (780.3%) stddev-sans-first:30880.05 02:05:53 INFO - PROCESS | 6762 | Values: 678.9 685.0 701.2 735.5 810.7 13798.8 14826.2 14888.9 15077.2 15101.0 13548.3 13870.7 13950.2 14572.2 14750.9 789.3 804.7 807.2 807.6 807.6 786.3 806.9 811.5 815.9 819.4 835.1 839.9 842.2 843.1 844.1 838.7 839.7 840.2 840.9 841.7 608.1 609.3 609.9 613.2 613.6 13524.1 13524.7 13529.5 13529.9 13531.5 14145.0 14427.7 14853.1 14876.7 14903.0 10776.2 10837.3 11212.5 11296.3 11305.8 3860.5 3876.1 3906.0 3949.9 3952.0 81074.0 81823.2 81988.6 82593.0 82865.0 11091.8 11305.7 11346.9 11351.2 11744.9 20583.7 20648.7 20664.4 20851.5 20929.2 8337.1 8483.0 8504.0 8552.0 8634.0 4751.6 4796.4 4894.5 4934.1 5062.0 3322.9 3433.1 3434.9 3440.5 3444.1 561.5 573.8 578.6 579.4 585.1 649.3 732.5 745.2 756.2 756.3 9856.7 9879.2 9960.9 10059.2 10177.3 527.9 649.9 695.3 711.6 742.3 4578.5 4722.6 4770.3 4806.1 4864.4 103620.0 121915.0 122058.0 122535.3 125916.4 105012.5 105379.0 105533.0 106070.0 107496.0 54049.0 55080.2 55847.2 87808.6 88300.6 8818.9 8823.3 8836.1 8850.0 8890.3 54448.7 54492.8 54929.7 55088.2 56139.4 74058.6 75327.0 83051.0 84426.0 86814.0 11925.9 11957.3 12042.9 12067.0 12647.6 13094.5 13868.9 14025.3 14101.5 14347.9 12703.9 12931.5 13285.0 13404.3 13425.5 12714.7 12822.2 12909.9 12978.0 13169.5 12099.9 12535.4 12748.9 12781.6 13032.5 10380.9 10876.9 11144.6 11160.3 11389.4 10592.5 11241.4 11758.8 11805.7 11879.8 02:05:53 INFO - PROCESS | 6762 | -------- Summary: end -------- 02:05:53 INFO - PROCESS | 6762 | 02:05:54 INFO - TEST-INFO | 6762: exit 0 02:05:54 INFO - TEST-OK | dromaeo_css | took 1110897ms 02:05:54 INFO - TEST-START | kraken 02:05:54 INFO - operating with platform_type : linux_ 02:05:54 INFO - Initialising browser for kraken test... 02:05:54 INFO - TEST-INFO | started process 7009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZKHAIZ/profile http://localhost:49246/getInfo.html) 02:05:58 INFO - PROCESS | 7009 | __metrics Screen width/height:1600/1200 02:05:58 INFO - PROCESS | 7009 | colorDepth:24 02:05:58 INFO - PROCESS | 7009 | Browser inner width/height: 1024/697 02:05:58 INFO - PROCESS | 7009 | __metrics 02:05:59 ERROR - PROCESS | 7009 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:05:59 INFO - TEST-INFO | 7009: exit 0 02:05:59 INFO - Browser initialized. 02:05:59 INFO - Running cycle 1/1 for kraken test... 02:05:59 INFO - TEST-INFO | started process 7132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZKHAIZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:11 INFO - PROCESS | 7132 | RSS: Main: 168325120 02:06:11 INFO - PROCESS | 7132 | 02:06:14 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 02:06:15 INFO - PROCESS | 7132 | RSS: Main: 173613056 02:06:15 INFO - PROCESS | 7132 | 02:06:17 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 02:06:18 INFO - PROCESS | 7132 | RSS: Main: 173178880 02:06:18 INFO - PROCESS | 7132 | 02:06:21 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 02:06:21 INFO - PROCESS | 7132 | RSS: Main: 168067072 02:06:21 INFO - PROCESS | 7132 | 02:06:23 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 02:06:24 INFO - PROCESS | 7132 | RSS: Main: 169136128 02:06:24 INFO - PROCESS | 7132 | 02:06:26 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:06:27 INFO - PROCESS | 7132 | RSS: Main: 169713664 02:06:27 INFO - PROCESS | 7132 | 02:06:30 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 02:06:31 INFO - PROCESS | 7132 | RSS: Main: 169181184 02:06:31 INFO - PROCESS | 7132 | 02:06:34 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 02:06:35 INFO - PROCESS | 7132 | RSS: Main: 167706624 02:06:35 INFO - PROCESS | 7132 | 02:06:38 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 02:06:38 INFO - PROCESS | 7132 | RSS: Main: 168525824 02:06:38 INFO - PROCESS | 7132 | 02:06:40 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:06:40 INFO - PROCESS | 7132 | RSS: Main: 169242624 02:06:40 INFO - PROCESS | 7132 | 02:06:42 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:06:43 INFO - PROCESS | 7132 | RSS: Main: 169459712 02:06:43 INFO - PROCESS | 7132 | 02:06:45 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:06:46 INFO - PROCESS | 7132 | RSS: Main: 169668608 02:06:46 INFO - PROCESS | 7132 | 02:06:48 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:06:49 INFO - PROCESS | 7132 | RSS: Main: 169664512 02:06:49 INFO - PROCESS | 7132 | 02:06:52 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:06:52 INFO - PROCESS | 7132 | RSS: Main: 169652224 02:06:52 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 02:06:54 INFO - PROCESS | 7132 | RSS: Main: 170442752 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | __start_tp_report 02:06:54 INFO - PROCESS | 7132 | _x_x_mozilla_page_load 02:06:54 INFO - PROCESS | 7132 | _x_x_mozilla_page_load_details 02:06:54 INFO - PROCESS | 7132 | |i|pagename|runs| 02:06:54 INFO - PROCESS | 7132 | |0;ai-astar;104;113;105;112;112;114;113;113;114;113 02:06:54 INFO - PROCESS | 7132 | |1;audio-beat-detection;158;119;145;167;119;146;140;122;181;118 02:06:54 INFO - PROCESS | 7132 | |2;audio-dft;169;163;162;163;161;164;168;166;161;164 02:06:54 INFO - PROCESS | 7132 | |3;audio-fft;76;75;75;169;76;75;76;76;182;75 02:06:54 INFO - PROCESS | 7132 | |4;audio-oscillator;84;86;146;84;84;84;146;86;84;155 02:06:54 INFO - PROCESS | 7132 | |5;imaging-gaussian-blur;117;118;118;117;118;118;117;117;117;117 02:06:54 INFO - PROCESS | 7132 | |6;imaging-darkroom;147;147;147;147;148;148;147;147;150;148 02:06:54 INFO - PROCESS | 7132 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;96;95 02:06:54 INFO - PROCESS | 7132 | |8;json-parse-financial;54;55;55;54;54;55;54;54;55;54 02:06:54 INFO - PROCESS | 7132 | |9;json-stringify-tinderbox;61;62;61;62;62;62;62;62;65;62 02:06:54 INFO - PROCESS | 7132 | |10;stanford-crypto-aes;85;81;74;75;74;76;76;80;79;83 02:06:54 INFO - PROCESS | 7132 | |11;stanford-crypto-ccm;119;121;127;131;127;130;123;120;206;131 02:06:54 INFO - PROCESS | 7132 | |12;stanford-crypto-pbkdf2;160;159;159;159;160;158;159;160;160;157 02:06:54 INFO - PROCESS | 7132 | |13;stanford-crypto-sha256-iterative;65;63;66;67;62;63;65;64;63;63 02:06:54 INFO - PROCESS | 7132 | __end_tp_report 02:06:54 INFO - PROCESS | 7132 | __start_cc_report 02:06:54 INFO - PROCESS | 7132 | _x_x_mozilla_cycle_collect,917 02:06:54 INFO - PROCESS | 7132 | __end_cc_report 02:06:54 INFO - PROCESS | 7132 | __startTimestamp1467709614627__endTimestamp 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | ------- Summary: start ------- 02:06:54 INFO - PROCESS | 7132 | Number of tests: 14 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.65 (3.2%) stddev-sans-first:2.76 02:06:54 INFO - PROCESS | 7132 | Values: 104.0 113.0 105.0 112.0 112.0 114.0 113.0 113.0 114.0 113.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:145.50 stddev:22.27 (15.3%) stddev-sans-first:22.80 02:06:54 INFO - PROCESS | 7132 | Values: 158.0 119.0 145.0 167.0 119.0 146.0 140.0 122.0 181.0 118.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.77 (1.7%) stddev-sans-first:2.30 02:06:54 INFO - PROCESS | 7132 | Values: 169.0 163.0 162.0 163.0 161.0 164.0 168.0 166.0 161.0 164.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.50 stddev:42.28 (56.0%) stddev-sans-first:44.25 02:06:54 INFO - PROCESS | 7132 | Values: 76.0 75.0 75.0 169.0 76.0 75.0 76.0 76.0 182.0 75.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:84.00 stddev:31.23 (37.2%) stddev-sans-first:32.28 02:06:54 INFO - PROCESS | 7132 | Values: 84.0 86.0 146.0 84.0 84.0 84.0 146.0 86.0 84.0 155.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:06:54 INFO - PROCESS | 7132 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 02:06:54 INFO - PROCESS | 7132 | Values: 147.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 150.0 148.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:06:54 INFO - PROCESS | 7132 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 02:06:54 INFO - PROCESS | 7132 | Values: 54.0 55.0 55.0 54.0 54.0 55.0 54.0 54.0 55.0 54.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.09 02:06:54 INFO - PROCESS | 7132 | Values: 61.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 65.0 62.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.50 stddev:3.89 (4.9%) stddev-sans-first:3.28 02:06:54 INFO - PROCESS | 7132 | Values: 85.0 81.0 74.0 75.0 74.0 76.0 76.0 80.0 79.0 83.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:128.50 stddev:25.87 (20.1%) stddev-sans-first:26.90 02:06:54 INFO - PROCESS | 7132 | Values: 119.0 121.0 127.0 131.0 127.0 130.0 123.0 120.0 206.0 131.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.50 stddev:0.99 (0.6%) stddev-sans-first:1.00 02:06:54 INFO - PROCESS | 7132 | Values: 160.0 159.0 159.0 159.0 160.0 158.0 159.0 160.0 160.0 157.0 02:06:54 INFO - PROCESS | 7132 | 02:06:54 INFO - PROCESS | 7132 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:1.60 (2.5%) stddev-sans-first:1.66 02:06:54 INFO - PROCESS | 7132 | Values: 65.0 63.0 66.0 67.0 62.0 63.0 65.0 64.0 63.0 63.0 02:06:54 INFO - PROCESS | 7132 | -------- Summary: end -------- 02:06:54 INFO - PROCESS | 7132 | 02:06:55 INFO - TEST-INFO | 7132: exit 0 02:06:55 INFO - TEST-OK | kraken | took 61236ms 02:06:55 INFO - SUITE-END | took 1172s 02:06:55 INFO - Completed test suite (00:19:32) 02:06:55 INFO - javascript benchmark 02:06:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7110.608267918353, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.3177101037772, 3129.2959084206072, 3169.2552250221192, 3170.286685495763, 3186.792858464201, 5369.731513424328, 5383.838484845451, 5383.946160538393, 5406.8377948661555, 5417.404085550586, 5275.762590683419, 5410.702411367373, 5423.945760542393, 5437.619366644337, 5470.5623550116, 4895.11887860185, 4918.2376731606655, 5016.47327030662, 5061.670991385567, 5109.182530795074, 4890.923996720733, 5064.670796398241, 5091.490850914897, 5101.801076746961, 5104.872378190556, 4872.074305881889, 4937.259411088366, 4957.330760347343, 4973.278874563186, 4975.477574854643, 4969.652124351297, 4987.301777751118, 4998.550130488274, 5003.349564556621, 5053.67151135175, 4937.284093806378, 4963.677360971561, 4968.3292755477905, 4969.180085285923, 5009.273655319958, 5226.503482169188, 5374.650647707926, 5379.811706590251, 5428.4300148484235, 5447.782088716486, 5779.479846813765, 5785.595008349417, 5792.131180322943, 5814.592978491507, 5818.825435236908, 5694.060480020791, 5844.941550584483, 5856.648601083906, 5901.645901245896, 5906.23218981534, 5422.566194704415, 5483.013057649621, 5484.478974497416, 5518.558515318765, 5524.751386187671, 6013.458788709037, 6016.09758536223, 6018.518518518596, 6023.789167379121, 6030.155778191057, 5599.188117722907, 5643.887122257532, 5765.0, 5776.162456443876, 5787.536997040227, 5763.0, 5782.971085144547, 5788.623739456922, 5806.390329015477, 5842.182094506772, 5592.161175823659, 5729.427057294237, 5766.250387449689, 5767.134929760486, 5805.8548536286935, 5696.743646535916, 5735.655860648291, 5798.9130163047585, 5839.766409343663, 5861.677607731615, 4423.093265880487, 4440.089781594766, 4445.622122119656, 4469.061497085649, 4478.596926276651, 3939.1530820873077, 3941.034446560611, 3942.48747662802, 3947.388154836005, 3982.143839074613, 5371.033214021436, 5418.566514678816, 5422.15956526739, 5603.411641777636, 5645.661260324394, 5682.460166284196, 5715.31416230055, 5717.028105222123, 5717.885642287214, 5785.27684039495, 5429.755660995185, 5471.781128754885, 5476.780928762805, 5480.972595136999, 5488.25908502355, 4984.22744474607, 5014.34813474246, 5038.899222015539, 5083.339165908408, 5083.517065878809, 6029.216201893726, 6087.756489740361, 6098.32918378978, 6116.847078823065, 6122.846928826815, 5927.407259274124, 5932.911006334822, 5933.821985340447, 5937.0, 5940.346561878104, 5874.0, 5945.91081133792, 5962.314333851663, 5993.340732519332, 6017.939820601738, 5688.829335119953, 5693.060644993529, 5707.886962042528, 5715.657060576379, 5727.968965586235, 5682.090865461506, 5775.682337471311, 5827.358990510956, 5839.708014599338, 5841.240638716939, 5466.398696143341, 5573.860653483695, 5626.718664066862, 5650.802221922378, 5706.172604972338, 5674.404187560247, 5695.829125126253, 5705.22979397776, 5710.029295019774, 5724.169995350734, 5630.324361076697, 5643.971780141237, 5644.0, 5657.745401456862, 5682.232898558807, 5533.0, 5656.943430565641, 5704.942950570441, 5754.0, 5760.33756118035, 5593.07714227148, 5608.439156084359, 5616.66300022, 5628.352739435018, 5629.915551266652], "value": 5363.063650718959, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.7618888161411, 615.9784407545735, 620.4385031546452, 623.2303105664504, 634.2420807135474, 37241.44137837931, 42663.57336426635, 42715.572844271584, 42731.57268427319, 42801.35797963033, 41078.58921410785, 41616.16767664645, 41898.37152442708, 41920.16159676805, 41926.37110443338, 8779.209871111614, 8942.105789421072, 8946.865797013017, 8947.50788706621, 8967.551622418885, 8532.0, 8558.78603034926, 8600.139986001412, 8624.35317351198, 8631.093735157812, 8820.338474614398, 8853.42452740573, 8860.24687901529, 8874.600642971081, 8883.333749968746, 8461.450005749606, 8507.787305317355, 8543.700970466034, 8560.14398560139, 8605.655773769073, 8814.294856411472, 8824.426412283181, 8837.425567338103, 8854.335924805666, 8892.199702026785, 32897.177570560685, 39805.60194398048, 39936.0, 40194.59805401967, 40203.3969490455, 3165.7625678074237, 3303.520989456539, 3343.1976325681903, 3373.0724050885956, 3492.109512074405, 30742.692573074208, 31076.223094422596, 31325.216869578217, 31403.37193256145, 32044.359112817845, 4227.387028880795, 4236.6187043166265, 4294.141171765659, 4341.1100724351745, 4349.717268377577, 308471.4576427126, 308479.0, 308960.0, 309100.0, 310723.0, 31456.0, 33179.83410082982, 34010.82994585011, 34800.47799283013, 35002.64997349994, 35269.0, 35588.28823423517, 35604.82197588996, 35929.0, 35953.46069808955, 15349.846501535065, 15387.692246155015, 15495.690086198212, 15500.30248638814, 15538.456154034555, 12700.936495317465, 12728.0, 12746.617601471971, 12769.936150319374, 12794.104412691022, 8183.6906095024515, 8253.917460825314, 8308.086110527836, 8314.875276870851, 8339.20777526134, 3245.123816569513, 3247.8213698246823, 3269.0683155300626, 3281.9179520511702, 3300.785448945811, 1048.7378155461136, 1070.9410982395887, 1078.417654466595, 1087.0814162033068, 1152.9077673786078, 32441.675583244338, 32762.0, 32832.343353132805, 33612.0, 33843.0, 1083.414955923808, 1111.4220605285207, 1124.5220781168134, 1127.4193790198055, 1155.930644161353, 15221.923890380478, 15372.769408458882, 15464.0, 15512.767308490382, 15804.841951580336, 260738.0, 262916.0, 262952.0, 264147.0, 507393.0, 56514.434855651736, 57174.0, 57261.0, 57322.42677573171, 57385.0, 1252.5177806544546, 1333.2600406774334, 1379.6275005748591, 1385.8544852790515, 1399.2234309957867, 30054.24864378408, 31266.37467250597, 31374.442497611286, 31532.0, 32026.67973320237, 48633.5136648629, 49499.50500495093, 49663.503364967335, 49734.0, 49759.751201243766, 535986.0, 538007.0, 538705.0, 541336.0, 541721.0, 27928.30179245535, 27972.16083517498, 28156.85921570461, 28187.57718634263, 28268.71731282743, 46148.307775382724, 46490.07019859651, 47209.29186062143, 47696.7615161922, 48112.0, 40404.59595404126, 41169.794151029055, 41176.58823411728, 41364.379534306405, 41616.3757543631, 40296.0, 40932.1813563733, 41318.31430956978, 41396.172076558905, 41710.0, 40228.79885600553, 40625.0, 41744.0, 42071.15857682768, 45090.0, 34339.31321373609, 36957.445638315985, 37492.2501549962, 37610.8119459401, 38148.0, 28706.856465718374, 28752.993645222316, 29241.707582924748, 29299.414011720073, 29363.706362936096], "value": 18213.915034993384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.7485709717393, 372.7912369073319, 375.6243756243756, 390.7089218532194, 391.2507548045493, 17684.911575442122, 18190.0, 18800.717989230172, 18805.43583692488, 18973.90513047433, 10198.490075496233, 10655.413952232624, 10712.73218169546, 10751.193660475457, 10759.139268858493, 4947.727874966884, 4965.950340496603, 4969.4036715594, 5091.745412729368, 5096.51583099605, 4979.626528010395, 5018.498150184989, 5027.522385373383, 5035.420926593433, 5037.59699224063, 5008.29883816266, 5066.392032956051, 5763.769449222026, 5785.421457854223, 5810.215620891189, 5587.3015873015875, 5758.280214973108, 5765.654060756368, 5780.132980052984, 5809.128630705407, 5154.840160963753, 5187.610929180289, 5213.843584692465, 5228.372595288552, 5248.501392367719, 21207.15171393158, 22337.776622233894, 22618.66072008921, 23652.053917843266, 23664.0, 2217.4899773052125, 2246.2475070851283, 2273.056681477185, 2346.483773569812, 2387.7731615496673, 9205.447673139566, 9422.575984080733, 9474.099960503741, 9498.762530936712, 9547.761305967337, 1901.3250296144945, 1908.5896532245633, 1941.4758015335922, 1980.1287433529344, 1980.722698822166, 79858.20141798625, 81503.18496815015, 86256.56871715601, 89717.0, 90843.54578227132, 10670.839937400946, 10680.145588353069, 10688.946555267174, 11018.44907754609, 11077.11383089351, 14502.85497145036, 14626.195559244345, 14659.633509162357, 14689.485867994568, 14702.852971470362, 7601.581912994728, 8014.438989270695, 8145.551994640352, 8222.794430139294, 8411.705590304433, 8028.638711258008, 8038.437309388287, 8105.392095592854, 8168.591570421455, 8207.343412527103, 4246.978765106216, 4476.0, 4598.724076555417, 4803.567678908915, 4805.13507568634, 1848.5840685845847, 1982.9504262393555, 1983.5041239690077, 1988.9403317900485, 2012.6276638821864, 900.1203131111668, 916.2212119698337, 984.5126662302206, 985.7979114281555, 1049.2550289294534, 18883.433496995112, 19759.901200494194, 19792.90103549473, 19934.80391176534, 20189.596208075756, 942.7548837302351, 942.8915674697361, 953.4231789767091, 997.1225321716843, 1033.204432586904, 10633.73415664599, 10756.300840445503, 10785.245032847626, 10785.83821242682, 10989.06592939609, 466060.0, 470825.5834883283, 471003.0, 516343.0, 521755.0, 96665.51667241618, 99215.0, 99459.50270248602, 100196.0, 101942.0, 1068.9198310126772, 1074.666853275487, 1079.3469950679882, 1085.7719878825378, 1086.4839201379282, 17035.48893533196, 17267.222974965905, 17608.647827043642, 17702.911485443004, 18016.0, 38418.615813841505, 38543.614563854004, 39241.215175696896, 41739.0, 43705.34441983309, 56350.0, 57265.427345726006, 57993.420065798804, 58191.709041454524, 58334.4166558346, 8193.959030204811, 8296.419250652396, 8324.084350721294, 8437.282830959437, 8812.64749410042, 12907.741845162856, 13239.139455935334, 14172.858271417566, 14176.362063706953, 14674.266286685837, 11733.413329333329, 11886.930176284175, 12217.45021474018, 12395.31321490376, 12552.686182845502, 12091.153619246568, 12260.019198463922, 12350.81473777876, 12369.319687417279, 12371.69070773238, 11391.088712902781, 11445.0, 11543.711407214887, 11709.414529273672, 12807.61577152687, 7459.515131516434, 7539.886901696369, 7746.49647772893, 8126.512409255463, 8254.42219044661, 8483.024452188078, 12031.805713321699, 12139.393030348623, 12896.613101606967, 13049.869501305246], "value": 8957.989633249446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1195.4022988505747, 1247.8128280757885, 1341.450005497746, 1721.9139043047853, 1724.5688577855535, 7203.315685009916, 8237.876431853527, 8389.87415188772, 8818.69134580289, 8882.289416846654, 8498.277646400047, 8613.483191008543, 8704.129587041292, 8791.428557143781, 8810.559472026405, 2214.081156320129, 2229.9108035678555, 2242.7420846602604, 2245.9101635934544, 2253.7746225377496, 2162.610730068587, 2193.309107631099, 2243.2036626997424, 2244.057495851738, 2251.2008237075847, 2202.614542455064, 2210.171185805323, 2236.7427745809277, 2250.707408036953, 2277.646964720471, 2221.6556433752794, 2236.3738153317017, 2236.4520692430297, 2237.7762223777654, 2238.742544607375, 2175.5866385386726, 2214.1254204589095, 2216.2464761981005, 2216.468047668564, 2219.034719896834, 8808.471491710454, 8835.469871807712, 8855.24730397917, 8858.247049000842, 8871.290296776242, 4897.14299997499, 5014.272930425068, 5019.84940451787, 5025.698458092526, 5027.547520723152, 3075.123589776903, 3111.7043880831284, 3162.810231386124, 3207.342494788563, 3218.227625369918, 1083.7399024234205, 1088.4992903264508, 1099.1261946752352, 1140.1790710688292, 1141.8686851012158, 12231.571894983634, 12271.263724176488, 12321.938390308082, 12323.938380308042, 12326.260424374477, 4157.646600039031, 4204.495460544693, 4337.414449049401, 4347.108842687305, 4373.081652852873, 10209.0, 10224.335418197794, 10229.94885025585, 10262.538185781657, 10286.074253317238, 4971.602271818246, 5016.122178618727, 5058.8482345528955, 5072.492750724972, 5075.492450754895, 3992.041909941593, 4373.825046998148, 4573.748443835554, 4643.048175124159, 4687.81248750053, 3717.628237176261, 3725.2735716535017, 3831.942520862189, 3831.9616803832164, 3837.9616203838164, 1174.6241202815017, 1205.8673545909942, 1213.5995121609847, 1215.3619349841226, 1236.5548402575066, 830.779843341515, 877.7366789962986, 905.7690288976269, 930.3534043839467, 951.7525443384632, 5464.754086066137, 5593.692346920959, 5610.635308705003, 5754.079347304411, 5768.2501274834, 952.5856252530172, 976.2385339435252, 979.2215188924822, 1008.3848852200152, 1016.9949150254201, 3819.2743378757946, 3872.8644497442456, 3908.6677632400997, 3923.058465968147, 3934.370500719871, 10502.737431564272, 11212.327260364404, 11255.943720281346, 11262.155338349656, 11282.717932051764, 10949.945250273857, 11123.221374503708, 11146.832797508045, 11186.832197517044, 11216.383098929637, 8259.380546458919, 8298.21166989147, 8363.790905227297, 8366.24703776663, 8384.622691978875, 5563.054280772198, 5671.517920976763, 5741.827745167651, 5776.191333213437, 5821.563382746226, 10074.748131296483, 10223.0, 10317.48412579383, 10359.378437293484, 10371.118454931415, 9743.80512389734, 10079.34484258521, 10474.109700675222, 10512.842307365549, 10578.047975682226, 7017.2631873652535, 7311.195768465571, 7445.292697193758, 7564.394848412004, 7784.455088144002, 8445.408821382443, 8494.617742201739, 8503.659853606034, 8531.53076580794, 8574.914250857411, 7168.605726684874, 7351.963240183765, 7419.703211871465, 7494.138174110047, 7833.5691536966015, 7520.172780993977, 7566.31903128721, 7846.058472983279, 7868.803279918048, 7897.723579674684, 6804.82987925286, 6886.24251332363, 6904.654767261516, 6930.099087118642, 6960.512764106464, 4863.829765958175, 5093.261477085876, 5115.18157094863, 5140.408852981955, 5228.9738551307, 4977.9751101244265, 5136.666116702402, 5214.113600687816, 5237.397699264633, 5247.58019358458], "value": 4522.720959284477, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.3438229601102, 294.2247178684168, 296.38647998642807, 298.634173137906, 299.238438174845, 5681.636407262264, 5691.772329106836, 5715.685637289947, 5722.885542289152, 5759.654420734759, 5521.343596920928, 5535.750891209896, 5553.555715542757, 5564.221009058725, 5568.192612071247, 4105.794710264489, 4173.290540608089, 4202.579742025803, 4216.262154123032, 4224.429701990238, 4239.766812825309, 4246.511651160125, 4253.29820579604, 4274.5939135782055, 4276.486821581399, 4246.97876510617, 4257.276263035292, 4259.723117997336, 4260.1266740318315, 4265.125649241898, 3955.4660120883746, 4131.566185550504, 4141.751494910285, 4153.937690934638, 4260.552641972595, 3511.894643160709, 3513.84187711551, 3523.40102182627, 3524.2599054198395, 3526.642242736565, 5475.479829416199, 5477.535109200836, 5521.5306698930235, 5544.6118771686, 5560.805371812007, 4554.908901821945, 4750.12122757291, 4770.379850619397, 4777.163996300668, 4798.304245884327, 5860.238169038041, 5861.560382971252, 5864.677442740647, 5891.911621325684, 5938.851528711773, 3930.449737036817, 3940.7044471664453, 3945.8495120159296, 3950.9802450987563, 3957.544882338539, 6067.1202675611785, 6067.393260673942, 6092.756289748405, 6094.329623741385, 6208.87582248357, 3992.6007399260425, 4015.2170326785995, 4016.738911970771, 4018.0, 4018.3771515415156, 4096.672266218696, 4100.236898133831, 4105.486814148231, 4118.052847845012, 4125.257453658371, 4681.133990211822, 4807.110684523374, 4825.4933232010835, 4837.733924634179, 4845.0, 5886.381929897385, 5904.76380944766, 5910.335591932943, 5915.048034148721, 5952.226210592596, 1408.3521580073282, 1421.4740545998047, 1421.7085497472992, 1424.9572512824632, 1425.4369524037947, 883.5052370672444, 891.772597987522, 895.2122132523338, 915.949622770754, 948.0850978805486, 5513.9448605514235, 5563.0, 5649.0114230009585, 5673.659580425106, 5701.144828275792, 5900.6164599301765, 5995.61028533144, 6020.862593779233, 6040.365761595057, 6067.696615169224, 5435.42927992563, 5668.348139963874, 5790.305163380422, 5792.189093526909, 5812.912806307909, 3171.444997125494, 3234.6118465784257, 3259.152620318687, 3288.3587700398193, 3290.6709329066903, 6188.752449902044, 6290.370962903673, 6339.017452294902, 6390.53017805898, 6422.325655806073, 6222.657753823492, 6231.9688401557705, 6242.439390152462, 6270.592411493239, 6295.150154729145, 6082.148499210114, 6295.213098362705, 6308.716107775161, 6319.873602527924, 6399.328070552618, 6094.573379863545, 6096.512279017757, 6106.969465152646, 6121.1430399743185, 6121.173641558333, 6023.27720673522, 6024.87950240984, 6044.516438684983, 6048.183495228088, 6130.295016073031, 6031.638101713911, 6207.720652570555, 6356.904646430215, 6399.424051835357, 6414.647194404352, 4186.581341865911, 4193.496780386251, 4199.916001680011, 4208.684348673923, 4217.0, 5834.241548598655, 6177.0, 6202.4417802398, 6212.347703491249, 6223.128761973237, 5867.149263356704, 5889.381614930542, 5897.823065308047, 5943.613665111754, 5961.7615295387695, 5935.436133567304, 5952.702364881825, 5964.403559644001, 5987.670678112746, 6031.306399763907, 5680.573956953328, 5835.153902684172, 5855.502282306052, 5894.616849904743, 5915.556333274935, 5994.100884867305, 6019.458248757458, 6025.728842202024, 6040.0939859019745, 6054.727537260922, 5609.186667933209, 5868.679547101868, 5873.706314684334, 5914.349421563538, 5926.422006427218], "value": 4407.979105998373, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.8913773796194, 684.9965750171249, 701.1866235167206, 735.4814855526854, 810.6797814863131, 13798.793018104736, 14826.184559849204, 14888.851111488882, 15077.246137693126, 15101.0, 13548.322583870817, 13870.722585548283, 13950.162990220568, 14572.198529080897, 14750.852491475081, 789.2817536042188, 804.6861723927673, 807.1887752808419, 807.5800583696504, 807.6042739057879, 786.2805532937384, 806.9354451643884, 811.4968719393984, 815.8776183572481, 819.3690858039306, 835.0855812884881, 839.9454035487673, 842.2125312832521, 843.0768308701962, 844.1010324004945, 838.6729175621513, 839.7102999465175, 840.231188462556, 840.9243168114868, 841.6801615386145, 608.0605464557269, 609.3419107364081, 609.9268087829445, 613.2487702564367, 613.6287546034674, 13524.053316267866, 13524.729505409936, 13529.458821647122, 13529.932350338186, 13531.458741650322, 14145.0, 14427.691569348854, 14853.108813471119, 14876.70246595062, 14903.0, 10776.245662803607, 10837.349759014485, 11212.495437705242, 11296.300915417409, 11305.830412543819, 3860.478835357247, 3876.1472476055505, 3906.0, 3949.9012524686827, 3951.980240098781, 81074.0, 81823.18176818216, 81988.59005704934, 82593.0, 82865.0, 11091.83362249567, 11305.660830175108, 11346.943265283786, 11351.205415620827, 11744.94127529374, 20583.691244631344, 20648.690269645966, 20664.380068597966, 20851.478713032295, 20929.162833486793, 8337.124601916832, 8482.957585212034, 8504.0, 8551.957240213758, 8634.0, 4751.64362672801, 4796.448408433005, 4894.461609222983, 4934.1118598651865, 5062.038212739568, 3322.8836990705695, 3433.055909624873, 3434.9141271467915, 3440.518327434161, 3444.0873168610337, 561.5227057001516, 573.8077743955738, 578.6238944685988, 579.3655946738314, 585.1047896718028, 649.2598437780933, 732.542161149271, 745.1840234942729, 756.2210922749576, 756.3042001358763, 9856.704298871045, 9879.209663226924, 9960.904300526936, 10059.195264378832, 10177.287589868638, 527.9208118782213, 649.938255865692, 695.2595485807599, 711.5623891306913, 742.2985278911485, 4578.5421457853945, 4722.598579120745, 4770.255702000573, 4806.110869489155, 4864.433015429213, 103620.0, 121915.0, 122058.0, 122535.26056066823, 125916.37041814733, 105012.47493762482, 105379.0, 105533.0, 106070.0, 107496.0, 54049.0, 55080.17379739307, 55847.16229256564, 87808.5609571948, 88300.55849720839, 8818.91181088181, 8823.250023748053, 8836.072212417603, 8850.0, 8890.288776897962, 54448.72775636255, 54492.82028718807, 54929.72535137299, 55088.17367739567, 56139.438605613424, 74058.62970685112, 75327.0, 83051.0, 84426.0, 86814.0, 11925.940370298093, 11957.282563046245, 12042.939785301018, 12067.0, 12647.620571382873, 13094.541691040768, 13868.861311386758, 14025.298735063003, 14101.506447274296, 14347.856521434653, 12703.93648031754, 12931.5473958411, 13285.003624728377, 13404.293523801893, 13425.462981480632, 12714.745705085661, 12822.23066616006, 12909.935450322688, 12977.961763058744, 13169.47322107105, 12099.879001209874, 12535.435905384462, 12748.936255319035, 12781.552645657357, 13032.47870085186, 10380.896191037993, 10876.891231087588, 11144.60993865211, 11160.330380177214, 11389.373584452935, 10592.470376481298, 11241.437928103725, 11758.764824703629, 11805.70485737829, 11879.821802672794], "value": 7408.5699401100355, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 105.0, 112.0, 112.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 119.0, 145.0, 167.0, 119.0, 146.0, 140.0, 122.0, 181.0, 118.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 162.0, 163.0, 161.0, 164.0, 168.0, 166.0, 161.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 169.0, 76.0, 75.0, 76.0, 76.0, 182.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 146.0, 84.0, 84.0, 84.0, 146.0, 86.0, 84.0, 155.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 150.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 65.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 74.0, 75.0, 74.0, 76.0, 76.0, 80.0, 79.0, 83.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 121.0, 127.0, 131.0, 127.0, 130.0, 123.0, 120.0, 206.0, 131.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 159.0, 160.0, 158.0, 159.0, 160.0, 160.0, 157.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 66.0, 67.0, 62.0, 63.0, 65.0, 64.0, 63.0, 63.0], "value": 64.1, "unit": "score"}]}]} 02:06:55 INFO - Return code: 0 02:06:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:06:55 ERROR - # TBPL SUCCESS # 02:06:55 INFO - Running post-action listener: _resource_record_post_action 02:06:55 INFO - ##### 02:06:55 INFO - ##### Finished run-tests step (success) 02:06:55 INFO - ##### 02:06:55 INFO - Running post-run listener: _resource_record_post_run 02:06:56 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566792192; Read time: 12; Write time: 493584 02:06:56 INFO - TinderboxPrint: CPU usage
13.3% 02:06:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:06:56 INFO - TinderboxPrint: I/O write bytes / time
566,792,192 / 493,584 02:06:56 INFO - TinderboxPrint: CPU idle
8,232.0 (86.7%) 02:06:56 INFO - TinderboxPrint: CPU user
1,209.7 (12.7%) 02:06:56 INFO - TinderboxPrint: Swap in / out
0 / 0 02:06:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 267599872; Read time: 0; Write time: 303776 02:06:56 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 298930176; Read time: 0; Write time: 189760 02:06:56 INFO - Running post-run listener: _upload_blobber_files 02:06:56 INFO - Blob upload gear active. 02:06:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:06:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:06:56 INFO - (blobuploader) - INFO - Open directory for files ... 02:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:57 INFO - (blobuploader) - INFO - Done attempting. 02:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:06:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:59 INFO - (blobuploader) - INFO - Done attempting. 02:06:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:06:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:02 INFO - (blobuploader) - INFO - Done attempting. 02:07:02 INFO - (blobuploader) - INFO - Iteration through files over. 02:07:02 INFO - Return code: 0 02:07:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:07:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:07:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55b125466768192d01b27e041314c7e791de6ef0b376bf9a0c8a1a7ab083d186095d3754d2da3975a4676805656438fd15a743475d7513aaba4f4a70f92f209a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07179a2c08ab72b76ee580dbebab0c8f9b48abeb46ac5b401d3a22028358d77db8c7a6ec1a7efecc9e8d9d08b1ece9f5afa3c77ed6abf6ffd906c50c58882e33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00966518062157112bb2ecf9d5610181a1995e1e485d01cff01f27525543664521658d43cc29ac17b30e4f56b9ad4494d6db406a77ba1ac85f1cb0a702f18a93"} 02:07:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:07:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:07:02 INFO - Contents: 02:07:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55b125466768192d01b27e041314c7e791de6ef0b376bf9a0c8a1a7ab083d186095d3754d2da3975a4676805656438fd15a743475d7513aaba4f4a70f92f209a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07179a2c08ab72b76ee580dbebab0c8f9b48abeb46ac5b401d3a22028358d77db8c7a6ec1a7efecc9e8d9d08b1ece9f5afa3c77ed6abf6ffd906c50c58882e33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00966518062157112bb2ecf9d5610181a1995e1e485d01cff01f27525543664521658d43cc29ac17b30e4f56b9ad4494d6db406a77ba1ac85f1cb0a702f18a93"} 02:07:02 INFO - Running post-run listener: copy_logs_to_upload_dir 02:07:02 INFO - Copying logs to upload dir... 02:07:02 INFO - mkdir: /builds/slave/test/build/upload/logs 02:07:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.209273 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-05 02:07:01.589084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 02:07:01.593428) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55b125466768192d01b27e041314c7e791de6ef0b376bf9a0c8a1a7ab083d186095d3754d2da3975a4676805656438fd15a743475d7513aaba4f4a70f92f209a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07179a2c08ab72b76ee580dbebab0c8f9b48abeb46ac5b401d3a22028358d77db8c7a6ec1a7efecc9e8d9d08b1ece9f5afa3c77ed6abf6ffd906c50c58882e33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00966518062157112bb2ecf9d5610181a1995e1e485d01cff01f27525543664521658d43cc29ac17b30e4f56b9ad4494d6db406a77ba1ac85f1cb0a702f18a93"} build_url:https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010230 build_url: 'https://queue.taskcluster.net/v1/task/RxUHogJASq281CixQdB_CA/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/Fx-Team/sha512/55b125466768192d01b27e041314c7e791de6ef0b376bf9a0c8a1a7ab083d186095d3754d2da3975a4676805656438fd15a743475d7513aaba4f4a70f92f209a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07179a2c08ab72b76ee580dbebab0c8f9b48abeb46ac5b401d3a22028358d77db8c7a6ec1a7efecc9e8d9d08b1ece9f5afa3c77ed6abf6ffd906c50c58882e33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00966518062157112bb2ecf9d5610181a1995e1e485d01cff01f27525543664521658d43cc29ac17b30e4f56b9ad4494d6db406a77ba1ac85f1cb0a702f18a93"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 02:07:01.888234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 02:07:01.888580) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467708392.177383-955938658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 02:07:01.968769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 02:07:01.972111) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 02:07:01.972436) ========= ========= Total master_lag: 0.44 =========