builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1467698013.23 results: success (0) buildid: 20160704205523 builduid: 8540c987c11f41629e2ae90c61b95a90 revision: 045e13e67ed43f96e9639a9fec9f8e8b45fd91ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.228382) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.228774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.229151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.287938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.288212) ========= 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-1467695884.920819-1460794285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 22:53:34-- 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% 46.9M=0s 2016-07-04 22:53:34 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.424859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.425215) ========= 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-1467695884.920819-1460794285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017063 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.500646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:33.500983) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 045e13e67ed43f96e9639a9fec9f8e8b45fd91ed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 045e13e67ed43f96e9639a9fec9f8e8b45fd91ed --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-1467695884.920819-1460794285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 22:53:34,478 truncating revision to first 12 chars 2016-07-04 22:53:34,479 Setting DEBUG logging. 2016-07-04 22:53:34,479 attempt 1/10 2016-07-04 22:53:34,479 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/045e13e67ed4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 22:53:34,783 unpacking tar archive at: autoland-045e13e67ed4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:34.261619) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:34.261906) ========= script_repo_revision: 045e13e67ed43f96e9639a9fec9f8e8b45fd91ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:34.262316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:34.262588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 22:53:34.273342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-04 22:53:34.273635) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:35 INFO - MultiFileLogger online at 20160704 22:53:35 in /builds/slave/test 22:53:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 22:53:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:53:35 INFO - {'append_to_log': False, 22:53:35 INFO - 'base_work_dir': '/builds/slave/test', 22:53:35 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:53:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:53:35 INFO - 'branch': 'Autoland-Non-PGO', 22:53:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:35 INFO - 'config_files': ('talos/linux_config.py',), 22:53:35 INFO - 'default_actions': ('clobber', 22:53:35 INFO - 'read-buildbot-config', 22:53:35 INFO - 'download-and-extract', 22:53:35 INFO - 'populate-webroot', 22:53:35 INFO - 'create-virtualenv', 22:53:35 INFO - 'install', 22:53:35 INFO - 'run-tests'), 22:53:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:35 INFO - 'download_minidump_stackwalk': True, 22:53:35 INFO - 'download_symbols': 'ondemand', 22:53:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:35 INFO - 'installer_path': 'installer.exe', 22:53:35 INFO - 'log_level': 'info', 22:53:35 INFO - 'log_name': 'talos', 22:53:35 INFO - 'log_to_console': True, 22:53:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:35 INFO - 'opt_config_files': (), 22:53:35 INFO - 'pip_index': False, 22:53:35 INFO - 'sps_profile': False, 22:53:35 INFO - 'sps_profile_interval': 0, 22:53:35 INFO - 'suite': 'dromaeojs', 22:53:35 INFO - 'system_bits': '32', 22:53:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:35 INFO - 'title': 'talos-linux64-ix-023', 22:53:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:35 INFO - 'use_talos_json': True, 22:53:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:53:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:35 INFO - 'work_dir': 'build'} 22:53:35 INFO - ##### 22:53:35 INFO - ##### Running clobber step. 22:53:35 INFO - ##### 22:53:35 INFO - Running pre-action listener: _resource_record_pre_action 22:53:35 INFO - Running main action method: clobber 22:53:35 INFO - rmtree: /builds/slave/test/build 22:53:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:53:36 INFO - Running post-action listener: _resource_record_post_action 22:53:36 INFO - ##### 22:53:36 INFO - ##### Finished clobber step (success) 22:53:36 INFO - ##### 22:53:36 INFO - ##### 22:53:36 INFO - ##### Running read-buildbot-config step. 22:53:36 INFO - ##### 22:53:36 INFO - Running pre-action listener: _resource_record_pre_action 22:53:36 INFO - Running main action method: read_buildbot_config 22:53:36 INFO - Using buildbot properties: 22:53:36 INFO - { 22:53:36 INFO - "project": "", 22:53:36 INFO - "product": "firefox", 22:53:36 INFO - "script_repo_revision": "production", 22:53:36 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 22:53:36 INFO - "repository": "", 22:53:36 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 22:53:36 INFO - "buildid": "20160704205523", 22:53:36 INFO - "pgo_build": "False", 22:53:36 INFO - "basedir": "/builds/slave/test", 22:53:36 INFO - "buildnumber": 31, 22:53:36 INFO - "slavename": "talos-linux64-ix-023", 22:53:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:53:36 INFO - "platform": "ubuntu64_hw", 22:53:36 INFO - "scheduler": "tests-autoland-linux64-talos", 22:53:36 INFO - "branch": "autoland", 22:53:36 INFO - "repo_path": "integration/autoland", 22:53:36 INFO - "revision": "045e13e67ed43f96e9639a9fec9f8e8b45fd91ed", 22:53:36 INFO - "stage_platform": "linux64", 22:53:36 INFO - "builduid": "8540c987c11f41629e2ae90c61b95a90", 22:53:36 INFO - "slavebuilddir": "test" 22:53:36 INFO - } 22:53:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:53:36 INFO - Running post-action listener: _resource_record_post_action 22:53:36 INFO - ##### 22:53:36 INFO - ##### Finished read-buildbot-config step (success) 22:53:36 INFO - ##### 22:53:36 INFO - ##### 22:53:36 INFO - ##### Running download-and-extract step. 22:53:36 INFO - ##### 22:53:36 INFO - Running pre-action listener: _resource_record_pre_action 22:53:36 INFO - Running main action method: download_and_extract 22:53:36 INFO - mkdir: /builds/slave/test/build/tests 22:53:36 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')]} 22:53:36 INFO - https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:53:48 INFO - Downloaded 1361 bytes. 22:53:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:53:48 INFO - Using the following test package requirements: 22:53:48 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:53:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:48 INFO - u'jsshell-linux-x86_64.zip'], 22:53:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:48 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:53:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:53:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:53:52 INFO - Downloaded 22709761 bytes. 22:53:52 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'] 22:53:52 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 22:53:53 INFO - Return code: 0 22:53:53 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 22:53:53 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')]} 22:53:53 INFO - https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:53:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:53:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:53:58 INFO - Downloaded 22709761 bytes. 22:53:58 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'] 22:53:58 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 22:53:59 INFO - Return code: 0 22:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:59 INFO - https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:53:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:54:00 INFO - Downloaded 14403333 bytes. 22:54:00 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'] 22:54:00 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 22:54:01 INFO - Return code: 0 22:54: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')]} 22:54:01 INFO - https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:54:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:54:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:54:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B0BSUnYoQtKTCjo8xS99lw/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 22:54:04 INFO - Downloaded 56480777 bytes. 22:54:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:54:04 INFO - mkdir: /builds/slave/test/properties 22:54:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:54:04 INFO - Writing to file /builds/slave/test/properties/build_url 22:54:04 INFO - Contents: 22:54:04 INFO - build_url:https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:54:05 INFO - Running post-action listener: _resource_record_post_action 22:54:05 INFO - Running post-action listener: set_extra_try_arguments 22:54:05 INFO - ##### 22:54:05 INFO - ##### Finished download-and-extract step (success) 22:54:05 INFO - ##### 22:54:05 INFO - ##### 22:54:05 INFO - ##### Running populate-webroot step. 22:54:05 INFO - ##### 22:54:05 INFO - Running pre-action listener: _resource_record_pre_action 22:54:05 INFO - Running main action method: populate_webroot 22:54:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:05 INFO - '--tppagecycles', 22:54:05 INFO - '7'], 22:54:05 INFO - 'tests': ['tsvgm']}}, 22:54:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:54:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:54:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:54:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:05 INFO - 'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:05 INFO - 'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['damp', 'tps']}, 22:54:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:05 INFO - 'tests': ['damp', 'tps']}, 22:54:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['dromaeo_dom']}, 22:54:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:54:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['basic_compositor_video']}, 22:54:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:54:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['a11yr', 22:54:05 INFO - 'ts_paint', 22:54:05 INFO - 'tpaint', 22:54:05 INFO - 'sessionrestore', 22:54:05 INFO - 'sessionrestore_no_auto_restore', 22:54:05 INFO - 'tabpaint']}, 22:54:05 INFO - 'other-e10s': {'tests': ['a11yr', 22:54:05 INFO - 'ts_paint', 22:54:05 INFO - 'tpaint', 22:54:05 INFO - 'sessionrestore', 22:54:05 INFO - 'sessionrestore_no_auto_restore', 22:54:05 INFO - 'tabpaint']}, 22:54:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:54:05 INFO - 'ts_paint', 22:54:05 INFO - 'tpaint', 22:54:05 INFO - 'sessionrestore', 22:54:05 INFO - 'sessionrestore_no_auto_restore', 22:54:05 INFO - 'tabpaint']}, 22:54:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:54:05 INFO - 'ts_paint', 22:54:05 INFO - 'tpaint', 22:54:05 INFO - 'sessionrestore', 22:54:05 INFO - 'sessionrestore_no_auto_restore', 22:54:05 INFO - 'tabpaint']}, 22:54:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['a11yr', 22:54:05 INFO - 'ts_paint', 22:54:05 INFO - 'tpaint', 22:54:05 INFO - 'sessionrestore', 22:54:05 INFO - 'sessionrestore_no_auto_restore', 22:54:05 INFO - 'tabpaint']}, 22:54:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['a11yr', 22:54:05 INFO - 'ts_paint', 22:54:05 INFO - 'tpaint', 22:54:05 INFO - 'sessionrestore', 22:54:05 INFO - 'sessionrestore_no_auto_restore', 22:54:05 INFO - 'tabpaint']}, 22:54:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['tsvgx', 22:54:05 INFO - 'tsvgr_opacity', 22:54:05 INFO - 'tart', 22:54:05 INFO - 'tscrollx', 22:54:05 INFO - 'cart']}, 22:54:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:54:05 INFO - 'tsvgr_opacity', 22:54:05 INFO - 'tart', 22:54:05 INFO - 'tscrollx', 22:54:05 INFO - 'cart']}, 22:54:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:05 INFO - 'talos_options': ['--disable-e10s'], 22:54:05 INFO - 'tests': ['tp5o']}, 22:54:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:05 INFO - 'tests': ['tp5o']}, 22:54:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:05 INFO - 'talos_options': ['--disable-e10s', 22:54:05 INFO - '--xperf_path', 22:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:05 INFO - 'tests': ['tp5n']}, 22:54:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:05 INFO - 'talos_options': ['--xperf_path', 22:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:05 INFO - 'tests': ['tp5n']}}, 22:54:05 INFO - 'talos.zip': {'path': '', 22:54:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:05 INFO - Running post-action listener: _resource_record_post_action 22:54:05 INFO - ##### 22:54:05 INFO - ##### Finished populate-webroot step (success) 22:54:05 INFO - ##### 22:54:05 INFO - ##### 22:54:05 INFO - ##### Running create-virtualenv step. 22:54:05 INFO - ##### 22:54:05 INFO - Running pre-action listener: _resource_record_pre_action 22:54:05 INFO - Running main action method: create_virtualenv 22:54:05 INFO - Creating virtualenv /builds/slave/test/build/venv 22:54:05 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 22:54:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:54:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:05 INFO - Using real prefix '/usr' 22:54:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:54:06 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:08 INFO - Installing pip.................done. 22:54:08 INFO - Return code: 0 22:54:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:54:08 INFO - Using env: {'DISPLAY': ':0', 22:54:08 INFO - 'HOME': '/home/cltbld', 22:54:08 INFO - 'LANG': 'en_US.UTF-8', 22:54:08 INFO - 'LANGUAGE': 'en_US:en', 22:54:08 INFO - 'LOGNAME': 'cltbld', 22:54:08 INFO - 'MAIL': '/var/mail/cltbld', 22:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:08 INFO - 'MOZ_NO_REMOTE': '1', 22:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:08 INFO - 'NO_EM_RESTART': '1', 22:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:08 INFO - 'PWD': '/builds/slave/test', 22:54:08 INFO - 'SHELL': '/bin/bash', 22:54:08 INFO - 'SHLVL': '1', 22:54:08 INFO - 'TERM': 'linux', 22:54:08 INFO - 'TMOUT': '86400', 22:54:08 INFO - 'USER': 'cltbld', 22:54:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:08 INFO - '_': '/tools/buildbot/bin/python'} 22:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:08 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 22:54:08 INFO - Cleaning up... 22:54:08 INFO - Return code: 0 22:54:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:54:08 INFO - Using env: {'DISPLAY': ':0', 22:54:08 INFO - 'HOME': '/home/cltbld', 22:54:08 INFO - 'LANG': 'en_US.UTF-8', 22:54:08 INFO - 'LANGUAGE': 'en_US:en', 22:54:08 INFO - 'LOGNAME': 'cltbld', 22:54:08 INFO - 'MAIL': '/var/mail/cltbld', 22:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:08 INFO - 'MOZ_NO_REMOTE': '1', 22:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:08 INFO - 'NO_EM_RESTART': '1', 22:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:08 INFO - 'PWD': '/builds/slave/test', 22:54:08 INFO - 'SHELL': '/bin/bash', 22:54:08 INFO - 'SHLVL': '1', 22:54:08 INFO - 'TERM': 'linux', 22:54:08 INFO - 'TMOUT': '86400', 22:54:08 INFO - 'USER': 'cltbld', 22:54:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:08 INFO - '_': '/tools/buildbot/bin/python'} 22:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:08 INFO - Downloading/unpacking psutil>=3.1.1 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:54:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:10 INFO - Installing collected packages: psutil 22:54:10 INFO - Running setup.py install for psutil 22:54:10 INFO - building 'psutil._psutil_linux' extension 22:54:10 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 22:54:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:54:11 INFO - building 'psutil._psutil_posix' extension 22:54:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:54:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:54:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:11 INFO - Successfully installed psutil 22:54:11 INFO - Cleaning up... 22:54:11 INFO - Return code: 0 22:54:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:54:11 INFO - Using env: {'DISPLAY': ':0', 22:54:11 INFO - 'HOME': '/home/cltbld', 22:54:11 INFO - 'LANG': 'en_US.UTF-8', 22:54:11 INFO - 'LANGUAGE': 'en_US:en', 22:54:11 INFO - 'LOGNAME': 'cltbld', 22:54:11 INFO - 'MAIL': '/var/mail/cltbld', 22:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:11 INFO - 'MOZ_NO_REMOTE': '1', 22:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:11 INFO - 'NO_EM_RESTART': '1', 22:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:11 INFO - 'PWD': '/builds/slave/test', 22:54:11 INFO - 'SHELL': '/bin/bash', 22:54:11 INFO - 'SHLVL': '1', 22:54:11 INFO - 'TERM': 'linux', 22:54:11 INFO - 'TMOUT': '86400', 22:54:11 INFO - 'USER': 'cltbld', 22:54:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:11 INFO - '_': '/tools/buildbot/bin/python'} 22:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:54:13 INFO - Installing collected packages: mozsystemmonitor 22:54:13 INFO - Running setup.py install for mozsystemmonitor 22:54:13 INFO - Successfully installed mozsystemmonitor 22:54:13 INFO - Cleaning up... 22:54:13 INFO - Return code: 0 22:54:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:54:13 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')]} 22:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:13 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')]} 22:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:13 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 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:13 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 22:54:13 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 22:54:13 INFO - Using env: {'DISPLAY': ':0', 22:54:13 INFO - 'HOME': '/home/cltbld', 22:54:13 INFO - 'LANG': 'en_US.UTF-8', 22:54:13 INFO - 'LANGUAGE': 'en_US:en', 22:54:13 INFO - 'LOGNAME': 'cltbld', 22:54:13 INFO - 'MAIL': '/var/mail/cltbld', 22:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:13 INFO - 'MOZ_NO_REMOTE': '1', 22:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:13 INFO - 'NO_EM_RESTART': '1', 22:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:13 INFO - 'PWD': '/builds/slave/test', 22:54:13 INFO - 'SHELL': '/bin/bash', 22:54:13 INFO - 'SHLVL': '1', 22:54:13 INFO - 'TERM': 'linux', 22:54:13 INFO - 'TMOUT': '86400', 22:54:13 INFO - 'USER': 'cltbld', 22:54:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:13 INFO - '_': '/tools/buildbot/bin/python'} 22:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:13 INFO - Downloading/unpacking jsonschema==2.5.1 22:54:13 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 22:54:13 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 22:54:13 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 22:54:13 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 22:54:13 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 22:54:13 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 22:54:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:16 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:16 INFO - warning: no files found matching '*.txt' 22:54:16 INFO - no previously-included directories found matching 'build' 22:54:16 INFO - no previously-included directories found matching 'dist' 22:54:16 INFO - no previously-included directories found matching '.git*' 22:54:16 INFO - Installing collected packages: jsonschema, functools32 22:54:16 INFO - Running setup.py install for functools32 22:54:16 INFO - warning: no files found matching '*.txt' 22:54:16 INFO - no previously-included directories found matching 'build' 22:54:16 INFO - no previously-included directories found matching 'dist' 22:54:16 INFO - no previously-included directories found matching '.git*' 22:54:16 INFO - Successfully installed jsonschema functools32 22:54:16 INFO - Cleaning up... 22:54:16 INFO - Return code: 0 22:54:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:54:16 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')]} 22:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:16 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')]} 22:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:16 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 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:16 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 22:54:16 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 22:54:16 INFO - Using env: {'DISPLAY': ':0', 22:54:16 INFO - 'HOME': '/home/cltbld', 22:54:16 INFO - 'LANG': 'en_US.UTF-8', 22:54:16 INFO - 'LANGUAGE': 'en_US:en', 22:54:16 INFO - 'LOGNAME': 'cltbld', 22:54:16 INFO - 'MAIL': '/var/mail/cltbld', 22:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:16 INFO - 'MOZ_NO_REMOTE': '1', 22:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:16 INFO - 'NO_EM_RESTART': '1', 22:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:16 INFO - 'PWD': '/builds/slave/test', 22:54:16 INFO - 'SHELL': '/bin/bash', 22:54:16 INFO - 'SHLVL': '1', 22:54:16 INFO - 'TERM': 'linux', 22:54:16 INFO - 'TMOUT': '86400', 22:54:16 INFO - 'USER': 'cltbld', 22:54:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:16 INFO - '_': '/tools/buildbot/bin/python'} 22:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:16 INFO - Downloading/unpacking blobuploader==1.2.4 22:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:19 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:19 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 22:54:19 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 22:54:19 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 22:54:19 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 22:54:19 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 22:54:19 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 22:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:54:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:19 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 22:54:19 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 22:54:19 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 22:54:19 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 22:54:19 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 22:54:19 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 22:54:20 INFO - Downloading docopt-0.6.1.tar.gz 22:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:20 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:20 INFO - Running setup.py install for blobuploader 22:54:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:54:20 INFO - Running setup.py install for requests 22:54:20 INFO - Running setup.py install for docopt 22:54:20 INFO - Successfully installed blobuploader requests docopt 22:54:20 INFO - Cleaning up... 22:54:20 INFO - Return code: 0 22:54:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:20 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 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:20 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 22:54:20 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 22:54:20 INFO - Using env: {'DISPLAY': ':0', 22:54:20 INFO - 'HOME': '/home/cltbld', 22:54:20 INFO - 'LANG': 'en_US.UTF-8', 22:54:20 INFO - 'LANGUAGE': 'en_US:en', 22:54:20 INFO - 'LOGNAME': 'cltbld', 22:54:20 INFO - 'MAIL': '/var/mail/cltbld', 22:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:20 INFO - 'MOZ_NO_REMOTE': '1', 22:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:20 INFO - 'NO_EM_RESTART': '1', 22:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:20 INFO - 'PWD': '/builds/slave/test', 22:54:20 INFO - 'SHELL': '/bin/bash', 22:54:20 INFO - 'SHLVL': '1', 22:54:20 INFO - 'TERM': 'linux', 22:54:20 INFO - 'TMOUT': '86400', 22:54:20 INFO - 'USER': 'cltbld', 22:54:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:20 INFO - '_': '/tools/buildbot/bin/python'} 22:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:21 INFO - Running setup.py (path:/tmp/pip-2LVk4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:21 INFO - Running setup.py (path:/tmp/pip-wUWKrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:21 INFO - Running setup.py (path:/tmp/pip-MKIiVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:21 INFO - Running setup.py (path:/tmp/pip-slQ_vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:21 INFO - Running setup.py (path:/tmp/pip-SIHUoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:21 INFO - Running setup.py (path:/tmp/pip-R5XnMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:21 INFO - Running setup.py (path:/tmp/pip-2l6HDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:21 INFO - Running setup.py (path:/tmp/pip-_YGedu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:21 INFO - Running setup.py (path:/tmp/pip-Sft5QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:21 INFO - Running setup.py (path:/tmp/pip-0Uzfrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:21 INFO - Running setup.py (path:/tmp/pip-iphutC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:21 INFO - Running setup.py (path:/tmp/pip-YY9y80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:22 INFO - Running setup.py (path:/tmp/pip-vbxB2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:22 INFO - Running setup.py (path:/tmp/pip-03kz77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:22 INFO - Running setup.py (path:/tmp/pip-_CjX2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:22 INFO - Running setup.py (path:/tmp/pip-MrXzr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:22 INFO - Running setup.py (path:/tmp/pip-daJabx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:22 INFO - Running setup.py install for manifestparser 22:54:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Running setup.py install for mozcrash 22:54:22 INFO - Running setup.py install for mozdebug 22:54:22 INFO - Running setup.py install for mozdevice 22:54:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Running setup.py install for mozfile 22:54:22 INFO - Running setup.py install for mozhttpd 22:54:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:54:22 INFO - Running setup.py install for mozinfo 22:54:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for mozInstall 22:54:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for mozleak 22:54:23 INFO - Running setup.py install for mozlog 22:54:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for moznetwork 22:54:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for mozprocess 22:54:23 INFO - Running setup.py install for mozprofile 22:54:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for mozrunner 22:54:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:54:23 INFO - Running setup.py install for mozscreenshot 22:54:23 INFO - Running setup.py install for moztest 22:54:24 INFO - Running setup.py install for mozversion 22:54:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:54:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:24 INFO - Cleaning up... 22:54:24 INFO - Return code: 0 22:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:24 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 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:24 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 22:54:24 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 22:54:24 INFO - Using env: {'DISPLAY': ':0', 22:54:24 INFO - 'HOME': '/home/cltbld', 22:54:24 INFO - 'LANG': 'en_US.UTF-8', 22:54:24 INFO - 'LANGUAGE': 'en_US:en', 22:54:24 INFO - 'LOGNAME': 'cltbld', 22:54:24 INFO - 'MAIL': '/var/mail/cltbld', 22:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:24 INFO - 'MOZ_NO_REMOTE': '1', 22:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:24 INFO - 'NO_EM_RESTART': '1', 22:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:24 INFO - 'PWD': '/builds/slave/test', 22:54:24 INFO - 'SHELL': '/bin/bash', 22:54:24 INFO - 'SHLVL': '1', 22:54:24 INFO - 'TERM': 'linux', 22:54:24 INFO - 'TMOUT': '86400', 22:54:24 INFO - 'USER': 'cltbld', 22:54:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:24 INFO - '_': '/tools/buildbot/bin/python'} 22:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:24 INFO - Running setup.py (path:/tmp/pip-cnu0vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:24 INFO - Running setup.py (path:/tmp/pip-qasVYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:24 INFO - Running setup.py (path:/tmp/pip-qlCa3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:24 INFO - Running setup.py (path:/tmp/pip-u1dify-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:24 INFO - Running setup.py (path:/tmp/pip-J7F18f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:24 INFO - Running setup.py (path:/tmp/pip-Amuf3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:24 INFO - Running setup.py (path:/tmp/pip-730_wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:24 INFO - Running setup.py (path:/tmp/pip-vTNQlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:24 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)) 22:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:24 INFO - Running setup.py (path:/tmp/pip-gIW_Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:25 INFO - Running setup.py (path:/tmp/pip-yWtF3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:25 INFO - Running setup.py (path:/tmp/pip-3RT7uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:25 INFO - Running setup.py (path:/tmp/pip-yvFCqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:25 INFO - Running setup.py (path:/tmp/pip-O1APgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:25 INFO - Running setup.py (path:/tmp/pip-itEAz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:25 INFO - Running setup.py (path:/tmp/pip-3aju7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:25 INFO - Running setup.py (path:/tmp/pip-75wyL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:25 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)) 22:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:25 INFO - Running setup.py (path:/tmp/pip-RJ7BzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:25 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)) 22:54:25 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)) 22:54:25 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)) 22:54:25 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)) 22:54:25 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)) 22:54:25 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)) 22:54:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:28 INFO - Downloading blessings-1.6.tar.gz 22:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:28 INFO - Installing collected packages: blessings 22:54:28 INFO - Running setup.py install for blessings 22:54:28 INFO - Successfully installed blessings 22:54:28 INFO - Cleaning up... 22:54:28 INFO - Return code: 0 22:54:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:28 INFO - Reading from file tmpfile_stdout 22:54:28 INFO - Current package versions: 22:54:28 INFO - argparse == 1.2.1 22:54:28 INFO - blessings == 1.6 22:54:28 INFO - blobuploader == 1.2.4 22:54:28 INFO - docopt == 0.6.1 22:54:28 INFO - functools32 == 3.2.3-2 22:54:28 INFO - jsonschema == 2.5.1 22:54:28 INFO - manifestparser == 1.1 22:54:28 INFO - mozInstall == 1.12 22:54:28 INFO - mozcrash == 0.17 22:54:28 INFO - mozdebug == 0.1 22:54:28 INFO - mozdevice == 0.48 22:54:28 INFO - mozfile == 1.2 22:54:28 INFO - mozhttpd == 0.7 22:54:28 INFO - mozinfo == 0.9 22:54:28 INFO - mozleak == 0.1 22:54:28 INFO - mozlog == 3.2 22:54:28 INFO - moznetwork == 0.27 22:54:28 INFO - mozprocess == 0.22 22:54:28 INFO - mozprofile == 0.28 22:54:28 INFO - mozrunner == 6.11 22:54:28 INFO - mozscreenshot == 0.1 22:54:28 INFO - mozsystemmonitor == 0.3 22:54:28 INFO - moztest == 0.7 22:54:28 INFO - mozversion == 1.4 22:54:28 INFO - psutil == 3.1.1 22:54:28 INFO - requests == 1.2.3 22:54:28 INFO - wsgiref == 0.1.2 22:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:28 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')]} 22:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:28 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')]} 22:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:28 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 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:28 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 22:54:28 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 22:54:28 INFO - Using env: {'DISPLAY': ':0', 22:54:28 INFO - 'HOME': '/home/cltbld', 22:54:28 INFO - 'LANG': 'en_US.UTF-8', 22:54:28 INFO - 'LANGUAGE': 'en_US:en', 22:54:28 INFO - 'LOGNAME': 'cltbld', 22:54:28 INFO - 'MAIL': '/var/mail/cltbld', 22:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:28 INFO - 'MOZ_NO_REMOTE': '1', 22:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:28 INFO - 'NO_EM_RESTART': '1', 22:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:28 INFO - 'PWD': '/builds/slave/test', 22:54:28 INFO - 'SHELL': '/bin/bash', 22:54:28 INFO - 'SHLVL': '1', 22:54:28 INFO - 'TERM': 'linux', 22:54:28 INFO - 'TMOUT': '86400', 22:54:28 INFO - 'USER': 'cltbld', 22:54:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:28 INFO - '_': '/tools/buildbot/bin/python'} 22:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 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)) 22:54:29 INFO - Cleaning up... 22:54:29 INFO - Return code: 0 22:54:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:29 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 0x165c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, '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-1467695884.920819-1460794285', '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 22:54:29 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 22:54:29 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 22:54:29 INFO - Using env: {'DISPLAY': ':0', 22:54:29 INFO - 'HOME': '/home/cltbld', 22:54:29 INFO - 'LANG': 'en_US.UTF-8', 22:54:29 INFO - 'LANGUAGE': 'en_US:en', 22:54:29 INFO - 'LOGNAME': 'cltbld', 22:54:29 INFO - 'MAIL': '/var/mail/cltbld', 22:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:29 INFO - 'MOZ_NO_REMOTE': '1', 22:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:29 INFO - 'NO_EM_RESTART': '1', 22:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:29 INFO - 'PWD': '/builds/slave/test', 22:54:29 INFO - 'SHELL': '/bin/bash', 22:54:29 INFO - 'SHLVL': '1', 22:54:29 INFO - 'TERM': 'linux', 22:54:29 INFO - 'TMOUT': '86400', 22:54:29 INFO - 'USER': 'cltbld', 22:54:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:29 INFO - '_': '/tools/buildbot/bin/python'} 22:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:54:29 INFO - Cleaning up... 22:54:29 INFO - Return code: 0 22:54:29 INFO - Running post-action listener: _resource_record_post_action 22:54:29 INFO - Running post-action listener: _start_resource_monitoring 22:54:29 INFO - Starting resource monitoring. 22:54:29 INFO - ##### 22:54:29 INFO - ##### Finished create-virtualenv step (success) 22:54:29 INFO - ##### 22:54:29 INFO - ##### 22:54:29 INFO - ##### Running install step. 22:54:29 INFO - ##### 22:54:29 INFO - Running pre-action listener: _resource_record_pre_action 22:54:29 INFO - Running main action method: install 22:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:29 INFO - Reading from file tmpfile_stdout 22:54:29 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:54:29 INFO - Reading from file tmpfile_stdout 22:54:29 INFO - Output received: 22:54:29 INFO - Usage: mozinstall [options] installer 22:54:29 INFO - Options: 22:54:29 INFO - -h, --help show this help message and exit 22:54:29 INFO - -d DEST, --destination=DEST 22:54:29 INFO - Directory to install application into. [default: 22:54:29 INFO - "/builds/slave/test"] 22:54:29 INFO - --app=APP Application being installed. [default: firefox] 22:54:29 INFO - mkdir: /builds/slave/test/build/application 22:54:29 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'] 22:54:29 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 22:54:45 INFO - Reading from file tmpfile_stdout 22:54:45 INFO - Output received: 22:54:45 INFO - /builds/slave/test/build/application/firefox/firefox 22:54:45 INFO - Running post-action listener: _resource_record_post_action 22:54:45 INFO - ##### 22:54:45 INFO - ##### Finished install step (success) 22:54:45 INFO - ##### 22:54:45 INFO - ##### 22:54:45 INFO - ##### Running run-tests step. 22:54:45 INFO - ##### 22:54:45 INFO - Running pre-action listener: _resource_record_pre_action 22:54:45 INFO - Running main action method: run_tests 22:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:54:45 INFO - Python 2.7.3 22:54:45 INFO - Return code: 0 22:54:45 INFO - grabbing minidump binary from tooltool 22:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:45 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 0x191b3b0>, '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 0x191c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:54:45 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 22:54:45 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 22:54:45 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 22:54:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:45 INFO - Return code: 0 22:54:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:54:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:54:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:54:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:54:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:54:45 INFO - Using env: {'DISPLAY': ':0', 22:54:45 INFO - 'HOME': '/home/cltbld', 22:54:45 INFO - 'LANG': 'en_US.UTF-8', 22:54:45 INFO - 'LANGUAGE': 'en_US:en', 22:54:45 INFO - 'LOGNAME': 'cltbld', 22:54:45 INFO - 'MAIL': '/var/mail/cltbld', 22:54:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:54:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:45 INFO - 'MOZ_NO_REMOTE': '1', 22:54:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:45 INFO - 'NO_EM_RESTART': '1', 22:54:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:45 INFO - 'PWD': '/builds/slave/test', 22:54:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:54:45 INFO - 'SHELL': '/bin/bash', 22:54:45 INFO - 'SHLVL': '1', 22:54:45 INFO - 'TERM': 'linux', 22:54:45 INFO - 'TMOUT': '86400', 22:54:45 INFO - 'USER': 'cltbld', 22:54:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467695884.920819-1460794285', 22:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:45 INFO - '_': '/tools/buildbot/bin/python'} 22:54:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:54:46 INFO - mozversion application_buildid: 20160704205523 22:54:46 INFO - mozversion application_changeset: 045e13e67ed43f96e9639a9fec9f8e8b45fd91ed 22:54:46 INFO - mozversion application_display_name: Nightly 22:54:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:46 INFO - mozversion application_name: Firefox 22:54:46 INFO - mozversion application_remotingname: firefox 22:54:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:54:46 INFO - mozversion application_vendor: Mozilla 22:54:46 INFO - mozversion application_version: 50.0a1 22:54:46 INFO - mozversion platform_buildid: 20160704205523 22:54:46 INFO - mozversion platform_changeset: 045e13e67ed43f96e9639a9fec9f8e8b45fd91ed 22:54:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:54:46 INFO - mozversion platform_version: 50.0a1 22:54:46 INFO - using testdate: 1467698086 22:54:46 INFO - actual date: 1467698086 22:54:46 INFO - starting webserver on 'localhost:53269' 22:54:46 INFO - SUITE-START | Running 2 tests 22:54:46 INFO - TEST-START | dromaeo_css 22:54:46 INFO - operating with platform_type : linux_ 22:54:46 INFO - Initialising browser for dromaeo_css test... 22:54:46 INFO - TEST-INFO | started process 30388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP46q76/profile http://localhost:53269/getInfo.html) 22:54:50 INFO - PROCESS | 30388 | __metrics Screen width/height:1600/1200 22:54:50 INFO - PROCESS | 30388 | colorDepth:24 22:54:50 INFO - PROCESS | 30388 | Browser inner width/height: 1024/697 22:54:50 INFO - PROCESS | 30388 | __metrics 22:54:51 INFO - PROCESS | 30388 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:54:52 INFO - TEST-INFO | 30388: exit 0 22:54:52 INFO - Browser initialized. 22:54:52 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:52 INFO - TEST-INFO | started process 30468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP46q76/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:04 INFO - PROCESS | 30468 | RSS: Main: 158978048 22:55:04 INFO - PROCESS | 30468 | 22:55:55 INFO - PROCESS | 30468 | 1467698155374 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] 22:58:08 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:53269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53269/tests/dromaeo/cssquery-ext.html) 22:58:09 INFO - PROCESS | 30468 | RSS: Main: 265580544 22:58:09 INFO - PROCESS | 30468 | 23:01:12 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:53269/tests/dromaeo/cssquery-ext.html (next: http://localhost:53269/tests/dromaeo/cssquery-jquery.html) 23:01:12 INFO - PROCESS | 30468 | RSS: Main: 241360896 23:01:12 INFO - PROCESS | 30468 | 23:04:14 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:53269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53269/tests/dromaeo/cssquery-mootools.html) 23:04:15 INFO - PROCESS | 30468 | RSS: Main: 242434048 23:04:15 INFO - PROCESS | 30468 | 23:07:17 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:53269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53269/tests/dromaeo/cssquery-prototype.html) 23:07:18 INFO - PROCESS | 30468 | RSS: Main: 239878144 23:07:18 INFO - PROCESS | 30468 | 23:10:21 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:53269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53269/tests/dromaeo/cssquery-yui.html) 23:10:22 INFO - PROCESS | 30468 | RSS: Main: 221442048 23:10:22 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:53269/tests/dromaeo/cssquery-yui.html (next: http://localhost:53269/tests/dromaeo/cssquery-dojo.html) 23:13:25 INFO - PROCESS | 30468 | RSS: Main: 273014784 23:13:25 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | __start_tp_report 23:13:25 INFO - PROCESS | 30468 | _x_x_mozilla_page_load 23:13:25 INFO - PROCESS | 30468 | _x_x_mozilla_page_load_details 23:13:25 INFO - PROCESS | 30468 | |i|pagename|runs| 23:13:25 INFO - PROCESS | 30468 | |0;dojo.html;2622.160908509277;2632.631431599578;2660.9068682596107;2683.731626837315;2687.3013016615687;4659.277811939146;4671.4627817800965;4742.762861856906;4832.081904438154;4848;4736.786844591993;4751.809927602892;4794.400699912511;4805.759712014394;4809.639277054226;4308.849190278341;4326.978365108186;4381.014271788854;4415.86752397427;4449.443819522559;4371.781410929457;4454.0646464242545;4480.731156130626;4488.5062643109395;4521.932171017437;4420.049689316812;4484.394606728082;4495.1459222747735;4496.5278645742055;4523.389342438762;4254.255505286563;4303.978480107579;4344.978275108604;4383.145286669101;4411.073674528353;4270.914581708348;4275.166342563201;4315.892102697427;4331.0255192581735;4344.717593356453;4739.526047395233;4758.476567577563;4767.046590681877;4773.498782627808;4786.52134786522;4985.651004429691;5058.519440653132;5095.5923526118195;5096.311997880276;5123.923141152885;5144.356955380577;5147.665401748912;5150.768215430277;5160.948390516084;5172.66377685453;4804.399450068741;4805.038992201574;4805.879853003633;4839.37088178538;4846.466888642247;5112.4120726116225;5187.636865419385;5229.47705229474;5233.607479439057;5255.02781985334;5070.670406423571;5083.364579427572;5087.135187018142;5088.618353623493;5090.745462726923;4980.7509624518625;5131;5142.254373115878;5169.586433085344;5181.81863634771;4774.689645173053;5020.974895125501;5089.847304580794;5093.745312734422;5117.565006974374;5100.209467532539;5102.158143906288;5105.897882042338;5106.183010718267;5149.407818100892;4250.128723611714;4300.161468513672;4311.827526898952;4334.371516130143;4367.061081867414;3764.6235376462137;3785.7539259948567;3796.677282431024;3820.67524260441;3829.425586162098;4400.779961002001;4423.800928958204;4428.490723566767;4428.955710442854;4470.2177119004045;5072.416672082684;5151.562117220078;5154.793808247703;5161.148410512224;5211.114110601206;4369.519352871182;4433.5788100131085;4445.133199026159;4446.822127114944;4457.064016556495;4628.375169352094;4633.189191891473;4634.976825115853;4653.092646933883;4688.156131896223;4700.553447422626;4711.481737008995;4825.806967721252;4831.106245344622;4836.056968891033;5086.593072554113;5093.18509038552;5124.256982737407;5170.43125256214;5185.066687996046;4761.8333358333675;4790.688605240648;4791.544803243825;4793.544613261734;4851.078295123915;4963.553280204799;5019.472955339636;5029.899402012013;5041.924371134362;5085.542301192911;5117.769700363567;5125.79496820123;5153.969206158708;5155.613329000415;5206.635535512478;4977.626677999092;4981.476944920876;4989.376327959005;5010.724410157331;5043.672161309503;4863.659543831898;4921.557059864629;4922.310876477368;5012.674176178537;5017.924731129109;4913.533214344631;4916.827911023097;4948.158813001726;4960.032793605213;4970.005998800182;5003.974980125076;5020.046191223656;5024.221245706921;5028.924566131438;5062.2406639002975;4855.975720121377;4863.416390033219;4883.853484395474;4899.828506002415;4910.8772280693265 23:13:25 INFO - PROCESS | 30468 | |1;ext.html;580.3587036324861;587.806024012076;589.2928485817018;594.4501336263954;604.6976511744128;27151.864240678795;39432.802835985814;41172.382414263775;41266.17467650645;44602.55397446024;41210.17579648405;41711;41734;41798.37302440458;41946;7813.101493328269;7958.880616790752;7967.840643187133;7996.320312773421;7999.240072193133;7876.881846772274;7958.084820245659;7960.402969777261;7973.083095444011;7997.720079797208;7995.000624921885;8036.116027237029;8038.075621303567;8044.959775201145;8051;7969.083555391147;7996.160403157643;8014.118446970829;8016.318612917879;8016.879746803803;7789.221077892222;7873.330766884822;7880.290773830326;7884.053913530356;7889.684412623488;39796.20407591832;40155.39766903499;40180;40215.59784402177;40247;3067.2791893904914;3192.393445245396;3196.408664397094;3502.5096486491657;3776.055986003499;30290.394192116255;30530.616312092206;30690.693093069007;31051.22371940697;31232.531512027337;2877.683454819968;2899.536074228113;2928.7364137227537;2943.8969636062634;2949;263992;264008;265133;265134;265255;32031.359372812414;53061.46938530565;53140.46859531355;53206.20190697143;53212.73393633007;32445;34495.13762155916;34507;34534.30931381408;34636;13444.395002224923;13744.931275343759;13750.312484375941;13752.93123534376;13756.587302380945;11168.888311116785;11363.090952723762;11368.772624547462;11373.658790236306;11392.772144557062;7918.683252669829;7954.164812694699;7963.243491868263;8018.919810801934;8037.638306276232;3072.8309942952906;3085;3085.691430856941;3124.734397576186;3133.122725636825;819.4837252530987;888.7111688701198;906.9773255668529;952.2286947572488;976.0776066616979;28090.2977425566;28651.856740716164;28903.56644650332;29202.269943251165;29254;932.3566738950103;935.499507763357;956.9664762056962;976.829054915387;1006.9949650251848;14900.70198596022;15123.16822574769;15416.229188540528;15615;15633.530994070195;403429;453555;461092;742831;745158;51772.48227517752;52160;52278.738606306724;52346;52359.214611780095;1099.7580532282884;1139.3334899083964;1179.0449735714099;1185.436917464215;1207.034372501995;27293.590596140675;32025.519617205293;32087.358252834347;32107.073575584604;32133.36435136808;47925.76037119792;49111.50888491069;49123.75438122787;49169.2624610624;49199;364407;370613;371262;371752;373070;22707;25405;25778.226653200432;26082.087126950464;26308.73691263063;42316.576834231266;42689.14621707611;43095.35356969711;43339.349909750745;43410.56589434065;36100.81949590235;36511.45232821563;36869;37408.81295593505;37741.62258377381;36151.45772813463;37243.44134837925;37583.62416375801;38810.417843731804;40438;36997;37398.252034958605;37527.624723752415;37789.81105094457;37935.24129517339;31231.687683123786;33692.74794863956;33954;34082.31835363229;34200.82899585486;25971.480570388863;26218.737812621628;26267.474650507265;26357.20928372152;26795.732042679323 23:13:25 INFO - PROCESS | 30468 | |2;jquery.html;369.16384389358103;377.3415390144197;379.93351163546373;387.22941346720035;390.3188935307886;16045.197740112992;16744.162791860403;17695.203715832788;17704.468865934028;17930;10339.069483746462;10559.26085174038;10568.15454763619;10603.628872989448;10638.042576168162;4616.307553866922;4792.784324705397;4983.152864013126;5357.732113394315;5361.571074314065;5253.7373131343475;5307.893842123155;5311.176767601028;5322.414534401232;5344.839654810343;5119.948800511985;5279.736013199325;5292.391374991887;5407.810726624569;5408.08062629352;5513.751881165337;5529.115341545374;5544.695041772701;5553.500184983351;5585.58108141889;5303.310569625963;5325.547328477084;5423.972880135613;5427.267318911936;5444.482774136451;12218.389080545938;12263.386830658521;12293;15805.683886322324;21256.14975400982;1905.3140869287045;2026.9391918242477;2132.7334083239593;2235.251190851067;2268.875211863347;9298.581563829577;9332.160105590461;9805.509724513817;9816.558254878548;12840.587535371102;1706.2833609883878;1756.4379398592455;1762.7972783129976;1768.9911550442293;1781.4477511971331;70624;70801.6459917697;71115.64442177756;71517.6424117876;74166.25833741702;10009.799804003878;10134.341267817568;10165.390076595428;10272;10655.254132210826;13325.800112998313;13416.731665366638;13507.189568625718;13521.121127126706;13608.319584020957;7334.596597187099;7367.5211111277595;7398.667059982314;7472.14070381913;7540.359069479046;7150.213476517579;7150.96424517874;7183.928160718326;7260.128784545888;7299.5620262784405;4429.202743506135;4430;4478.977605112019;4514.45826500822;4575.107853968444;1815.5188874948149;1869.1775618727715;1904;1923.4998900286027;1952.6094781043848;804.9114597394282;865.6277800545699;913.6117150211134;926.8841394825647;943.4952300519326;17176.65646687084;17313.2209050593;17886.910565447088;18095.63808723818;18114.456566303033;858.5621333120154;863.9891327147253;865.9956700216459;877.6006916852816;960.596549449233;7315.743948961761;9601.519924003911;9728.221742260603;10473;10531.210159238088;400868;405297.84106476855;405755;407007;407105;82465.58767206126;83537.58231208926;84264.15735842686;86223;87421;947.1097168661436;951.3863558005048;955.5222388805597;977.8582105594792;978.0512902484578;15047.849521504644;16174.514764557081;16366.918165409097;16463.506094816694;16530.504084877473;38907.416388754755;40156.1968760629;40623.39064914088;40965.18069638531;41400.58599414088;49026.264606031655;51852.481475184766;52246.47753522416;52770;53769.19346209888;4849.660523763303;5278.656887302313;6951.131108611424;7674.330343766783;7932.6430310635005;9760;11999.520019199133;12006.519739210684;12045.09661775388;12069.879301206876;9798.363106398061;9809.41143531362;10193.286469947032;10194.541245644112;10570.995755403224;9855.240532650869;9858.408495490294;10081.89918100839;10218.897811021794;10601.734956626146;10014.499275036365;10131.79736405253;10307.742306442398;10313.484325783531;10489.971218958817;7559.357454616419;7683.615819209129;7720.8455830884195;7729.806754831175;7753.457257991887;9876.85184722244;9940.950295248478;10098.646547370807;10171.288009839536;10318.380897146195 23:13:25 INFO - PROCESS | 30468 | |3;mootools.html;1262.621213635909;1375.2092546785595;1412.0257022654368;1491.395984626226;1699.1419333236722;6778.051072849798;7807.5315481071175;8081.232282933127;8109.837803243931;8128.878066829002;7761.45669803114;7935.801604959879;7946.801329966754;7947.801304967379;7948;2106.115431518762;2132.402927180392;2133.0827744070043;2135.1886283212357;2135.829133669303;2158.4495953531905;2189.2337681811396;2208.933731988043;2210.7015552900393;2212.203606701586;2179.455136215946;2200.0539767899795;2208.436848603612;2211.5355775287208;2212.7565967743535;2129.371835308588;2136.39112852837;2141.6787481877686;2144.1637761273037;2145.0668959002883;2107.725995620575;2155.5904378168257;2157.244964262511;2157.7410710714657;2161.275972549198;7738.922610773877;7856.882146767803;7876.960615196945;7955.641996110131;8049.9195008049755;4619.630429565626;4734.479207287196;4735.668503204777;4739.502352252998;4742.810287588492;2896.884124635012;2916.518774402221;2980.9850950745326;3002.789804713671;3024.2439390152463;884.593087179898;896.7444278380631;897.4929165021807;909.5725009245645;912.1972664055588;10741.409222492759;10831.891681083245;10833.566657333697;10872.18458615607;10887.401192934385;4008.939865902014;4112.383142528644;4260.957390426118;4281.871543853689;4287.6355509782015;8448.915510844936;8497.192766687154;8528.104549022388;8538.615762290712;8557.973043234852;4631.02748422835;4634;4634.675572709878;4638.8608341749805;4648.418947631546;3750.624937506282;4166.729162604421;4277.786110694515;4292.59220374064;4306.547812479645;3475.565554305712;3514.63096374877;3573.5711714593895;3616.1863580694135;3618.7105031597407;1043.0664555223034;1047.874255089379;1051.3008849115406;1053.6680945502142;1057.7778666480126;764.7399884039453;800.1718221640574;839.6179738219096;843.8185790055168;850.3239924260228;5042.773075211624;5265.526102650703;5279.973600131974;5310.548603368757;5348.411674715778;865.6970060478908;889.8175873945826;891.6567121658209;905.180811365715;907.4328544659588;3648.288583726148;3659.524261845996;3765.661090501868;3844.961550384516;3875.5930627284292;9809.264305177141;9826.164775993977;9898.653547125816;9944.751381215383;9948.900510994943;9727.464989425507;9733.124018838338;9745.756356091155;9791.559379827782;9815.852762208573;6939.167299923941;7242.529235599669;7285.599292038883;7297.70809167638;7519.624018799148;5330.573554115739;5392.973035134956;5408.5673146149;5481.835544933659;5549.805756798492;9159.129882661136;9163.175314221751;9171.954140229256;9185.127412895765;9238;8499;8854.690085846965;8867.64529418816;9222.631094756134;9236.399634023766;6093.5375509878195;6750.6624668767345;6901.861962760616;7089.929100708927;7369.152547457111;7416.592087435243;7677.30904218623;7749.147593764568;7750.379969602531;7756.534607923542;6862.622555759282;6919.6194209316955;6985.301469852974;7013.649317534205;7094.787156385317;6698.531102822755;6714.026466162477;6792.76225332111;6900;6940.236573976959;5842.094475356326;5846.5615078870105;6187.535934804818;6329.810105696836;6401.775937842153;4606.539346065367;4618.399608050931;4625.583697467244;4638.744869032235;4657.045305712389;4622.537746225485;4670.78981445829;4677.602403795716;4724;4729.030548737569 23:13:25 INFO - PROCESS | 30468 | |4;prototype.html;300.54617527533424;312.09959267513216;314.098537198241;319.27524519341097;320.76904628667353;4857.684250523718;4875.878103047426;4878.682885612433;4882.633802464811;4901.6078713702955;4794.256890182019;4822.614190864731;4829.681752758678;4845.830395936143;4846.927296090562;3644.234710710754;3728.5152930119184;3744.569374521924;3823.6941044716355;3872.7095467839886;3802.676772474343;3819.2934307153264;3844.2311537692435;3868.729188956774;3869.6323849234277;3610.115521697188;3797.715171362145;3797.886063418102;3806.6193380661853;3813.5805061443357;3643.362411577963;3769.754965927206;3770;3781.640744129303;3812.5806161322234;3347.6652334766572;3365.1923538350866;3372.1738174147245;3379.4423920053164;3382.949255761141;4687.929681054787;4707.882302942419;4710.3641008463765;4713.740744259065;4723.385959825201;4284.464441944757;4358.869233922987;4371.650267978554;4381.298992161239;4390.1219756048595;5038.84883453497;5051.676228934694;5056.772445239936;5061.772220250061;5075.847724568269;3709.5919448860604;3717.3494638438165;3733.9171640224304;3737.794421306827;3740.7942563159017;5144.871378215537;5250.81622143227;5268.789248430058;5269.657472264329;5275.894482110336;3746.550413950343;3752.5309336332957;3757.1546402059316;3765.86819461323;3772.811359432072;3822.636849499349;3830.3871380578976;3831.233753249361;3847;3852.5569559500454;4345.130973805251;4349.3041113421705;4350.6736994725525;4353.847615333511;4355.956440435555;4893.975530122327;5013.874653133628;5016.949830501721;5022.6233032522705;5030.2957585938;1301.2387753164505;1314.921104733719;1319.103009953241;1320.650027742649;1320.9603711888658;862.8964524257129;863.8013256950936;891.7235656946367;898.9190972812478;900.9369344145847;4346.304941072984;4362.578768783355;4491.752953587584;4493.303537951622;4535.297028960516;5155.458676838953;5192.8961420771375;5199.194124910569;5199.7140157291715;5208.557272631793;4245.448091748053;4451.08752705701;4456.62118719906;4475.7985890635;4486.506484286726;2714.5792402177694;2738.1101142128887;2742.067696983035;2760.9585856212175;2764.4885696146275;4889.486603906538;4922.926156107661;4929.926051109236;4940.678855874428;4978.551930326215;5086.796528138833;5359.249705041298;5360.517553420211;5363.678179309176;5375.139977603565;4906.2640603909695;4906.411230652345;4917.164082106051;4918.655694101379;4972;5240.502152295526;5245;5270.129104167965;5296.761645726028;5303.443138470405;4940.901181976412;5157.097507936021;5164.922526162186;5171.974140129275;5212.582993360598;4910.950890491049;4930.4822993586595;4933.3719872442725;4953.281774142802;4973;3736.925261494809;3746.213295207928;3746.94379584301;3748.4564738112276;3751.8124093795745;5136.486351364833;5193.662411943212;5252.737363131904;5257.39539952895;5301.946980530145;5037.471065538212;5048.697078175322;5056.544910958031;5056.862206003767;5108.795648174031;5046.621503387188;5048.469910659474;5108.28484012246;5125.513076257749;5133.1273683473155;4768.403949506312;4901.90196196067;4972.453030166751;4987.551120399182;4995.825146119869;4945.381827271591;5069.442361340323;5077.695338279567;5082.847514574569;5096.643234973516;4993.375828021497;5000.2499625056535;5003.624728145476;5004.2493625956395;5009.223570346602 23:13:25 INFO - PROCESS | 30468 | |5;yui.html;636.6021236727046;709.755134478605;734.9783800517279;755.6323055269966;768.65794721349;12994.675133121666;13728.862711372896;13731.382087806047;13737.58787236382;13755.724885502284;12696.174748641331;12926.35368231587;12934.611961641142;13084.542041028566;13104.73790524189;776.39441235836;794.5471081483556;795.5664163031133;796.8605494038549;798.3613109512396;618.9102580125879;637.3785559079906;772.2856357868977;794.6146119132217;798.1579433697447;836.9079401265856;840.8696652018947;841.1630427724392;842.296682270302;842.8187939592987;646.1567654211252;838.7777239031661;839.2488722593275;839.8068444257824;839.9496030238145;586.2408181405048;600.687642425936;600.7987324246383;604.7218279591393;606.0696830365412;13482.52811151605;13497.527586534523;13506.86493135066;13514.729705405935;13524.323783810869;12709.872901270961;13193.20840749558;13217.867821321759;13424.530141445002;13502;11296.096312295078;11301.717457063556;11312.151588630886;11583.36291503967;11772.470238839272;3317;3372.0558243691808;3374.96625033749;3474;3547.8935631930826;62091.689541552456;62242;62271.68864155695;62480.37519624791;64628.67685661636;9132.726018219464;9197.95401023004;9255.629774809067;9276.489793061312;9308;17246.82753172452;17872.91063544674;19529.8047019528;19560.119794609276;19561.510962226057;6724.7646332378135;6878.105846239957;6903.827404314932;6919.550229235084;7130.429565634737;3708.592054873962;3765.6987441004653;3842.6733727632904;3860.517435320585;3874.050857539921;3407.6421975692197;3618.9276214475562;3626.673599376069;3650.780953142767;3652.433872749728;593.6823799267371;601.338527619615;602.0607851751195;603.1646170054419;620.996895015522;545.7053191276746;579.4061087385379;587.7325816753367;597.1878245585999;603.3212635784743;7590.658420371096;8062.677492900336;8203.113283944725;8461.323094152453;8544.871826922601;509.29462694168103;522.7281813456981;530.8911673107003;605.5255452972027;623.834683808791;3837.520309961255;3950.0914789598555;3974.145558704892;4011.919761604752;4107.835686572504;109535;110832;110932.44533777279;112361.4381928085;115470;95130.52434737782;95163;95891.52054239684;96013;97277;62224.37775622276;76244.85632715514;76692;79343.20656793474;79907;7216.9278307216255;7460.888086678596;7566.508176968479;7609.505382150142;7617.5048621839405;46596.30105548487;46856.7657161712;48199.75900120477;48803.26795098005;49107.26339104845;66609;70830.29169708237;71932.72773631099;72397.27602723906;73063;10186.490675466346;10205.540750666089;10632.30889992148;10698.304610200312;10997.780044399227;11614.247821144292;12098.334591597546;12410.75178496407;12543.623691289276;12664.493420263454;10493.737656558342;10928.836067459153;11144.944275278573;11268.211225214156;11475.139364547525;11026.338419694845;11339.603113890975;11348.262362946381;11611;11732.472038758448;10603.946980265358;10774.569017239537;11222.719432014264;11236.887631123584;11561.88438115608;8744.562771861509;8937.240334571634;9097.954510227406;9200.125988031126;9362.438253704799;9378.249740020918;9647.469389183661;9657.71026869195;9805.559699636866;9853.06395892389 23:13:25 INFO - PROCESS | 30468 | __end_tp_report 23:13:25 INFO - PROCESS | 30468 | __start_cc_report 23:13:25 INFO - PROCESS | 30468 | _x_x_mozilla_cycle_collect,985 23:13:25 INFO - PROCESS | 30468 | __end_cc_report 23:13:25 INFO - PROCESS | 30468 | __startTimestamp1467699205596__endTimestamp 23:13:25 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | ------- Summary: start ------- 23:13:25 INFO - PROCESS | 30468 | Number of tests: 6 23:13:25 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | [#0] dojo.html Cycles:165 Average:4726.49 Median:4839.37 stddev:497.18 (10.3%) stddev-sans-first:470.50 23:13:25 INFO - PROCESS | 30468 | Values: 2622.2 2632.6 2660.9 2683.7 2687.3 4659.3 4671.5 4742.8 4832.1 4848.0 4736.8 4751.8 4794.4 4805.8 4809.6 4308.8 4327.0 4381.0 4415.9 4449.4 4371.8 4454.1 4480.7 4488.5 4521.9 4420.0 4484.4 4495.1 4496.5 4523.4 4254.3 4304.0 4345.0 4383.1 4411.1 4270.9 4275.2 4315.9 4331.0 4344.7 4739.5 4758.5 4767.0 4773.5 4786.5 4985.7 5058.5 5095.6 5096.3 5123.9 5144.4 5147.7 5150.8 5160.9 5172.7 4804.4 4805.0 4805.9 4839.4 4846.5 5112.4 5187.6 5229.5 5233.6 5255.0 5070.7 5083.4 5087.1 5088.6 5090.7 4980.8 5131.0 5142.3 5169.6 5181.8 4774.7 5021.0 5089.8 5093.7 5117.6 5100.2 5102.2 5105.9 5106.2 5149.4 4250.1 4300.2 4311.8 4334.4 4367.1 3764.6 3785.8 3796.7 3820.7 3829.4 4400.8 4423.8 4428.5 4429.0 4470.2 5072.4 5151.6 5154.8 5161.1 5211.1 4369.5 4433.6 4445.1 4446.8 4457.1 4628.4 4633.2 4635.0 4653.1 4688.2 4700.6 4711.5 4825.8 4831.1 4836.1 5086.6 5093.2 5124.3 5170.4 5185.1 4761.8 4790.7 4791.5 4793.5 4851.1 4963.6 5019.5 5029.9 5041.9 5085.5 5117.8 5125.8 5154.0 5155.6 5206.6 4977.6 4981.5 4989.4 5010.7 5043.7 4863.7 4921.6 4922.3 5012.7 5017.9 4913.5 4916.8 4948.2 4960.0 4970.0 5004.0 5020.0 5024.2 5028.9 5062.2 4856.0 4863.4 4883.9 4899.8 4910.9 23:13:25 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | [#1] ext.html Cycles:180 Average:53697.94 Median:37555.62 stddev:114192.06 (304.1%) stddev-sans-first:114442.75 23:13:25 INFO - PROCESS | 30468 | Values: 580.4 587.8 589.3 594.5 604.7 27151.9 39432.8 41172.4 41266.2 44602.6 41210.2 41711.0 41734.0 41798.4 41946.0 7813.1 7958.9 7967.8 7996.3 7999.2 7876.9 7958.1 7960.4 7973.1 7997.7 7995.0 8036.1 8038.1 8045.0 8051.0 7969.1 7996.2 8014.1 8016.3 8016.9 7789.2 7873.3 7880.3 7884.1 7889.7 39796.2 40155.4 40180.0 40215.6 40247.0 3067.3 3192.4 3196.4 3502.5 3776.1 30290.4 30530.6 30690.7 31051.2 31232.5 2877.7 2899.5 2928.7 2943.9 2949.0 263992.0 264008.0 265133.0 265134.0 265255.0 32031.4 53061.5 53140.5 53206.2 53212.7 32445.0 34495.1 34507.0 34534.3 34636.0 13444.4 13744.9 13750.3 13752.9 13756.6 11168.9 11363.1 11368.8 11373.7 11392.8 7918.7 7954.2 7963.2 8018.9 8037.6 3072.8 3085.0 3085.7 3124.7 3133.1 819.5 888.7 907.0 952.2 976.1 28090.3 28651.9 28903.6 29202.3 29254.0 932.4 935.5 957.0 976.8 1007.0 14900.7 15123.2 15416.2 15615.0 15633.5 403429.0 453555.0 461092.0 742831.0 745158.0 51772.5 52160.0 52278.7 52346.0 52359.2 1099.8 1139.3 1179.0 1185.4 1207.0 27293.6 32025.5 32087.4 32107.1 32133.4 47925.8 49111.5 49123.8 49169.3 49199.0 364407.0 370613.0 371262.0 371752.0 373070.0 22707.0 25405.0 25778.2 26082.1 26308.7 42316.6 42689.1 43095.4 43339.3 43410.6 36100.8 36511.5 36869.0 37408.8 37741.6 36151.5 37243.4 37583.6 38810.4 40438.0 36997.0 37398.3 37527.6 37789.8 37935.2 31231.7 33692.7 33954.0 34082.3 34200.8 25971.5 26218.7 26267.5 26357.2 26795.7 23:13:25 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | [#2] jquery.html Cycles:180 Average:24854.12 Median:4595.71 stddev:67113.04 (1460.3%) stddev-sans-first:67276.12 23:13:25 INFO - PROCESS | 30468 | Values: 369.2 377.3 379.9 387.2 390.3 16045.2 16744.2 17695.2 17704.5 17930.0 10339.1 10559.3 10568.2 10603.6 10638.0 4616.3 4792.8 4983.2 5357.7 5361.6 5253.7 5307.9 5311.2 5322.4 5344.8 5119.9 5279.7 5292.4 5407.8 5408.1 5513.8 5529.1 5544.7 5553.5 5585.6 5303.3 5325.5 5424.0 5427.3 5444.5 12218.4 12263.4 12293.0 15805.7 21256.1 1905.3 2026.9 2132.7 2235.3 2268.9 9298.6 9332.2 9805.5 9816.6 12840.6 1706.3 1756.4 1762.8 1769.0 1781.4 70624.0 70801.6 71115.6 71517.6 74166.3 10009.8 10134.3 10165.4 10272.0 10655.3 13325.8 13416.7 13507.2 13521.1 13608.3 7334.6 7367.5 7398.7 7472.1 7540.4 7150.2 7151.0 7183.9 7260.1 7299.6 4429.2 4430.0 4479.0 4514.5 4575.1 1815.5 1869.2 1904.0 1923.5 1952.6 804.9 865.6 913.6 926.9 943.5 17176.7 17313.2 17886.9 18095.6 18114.5 858.6 864.0 866.0 877.6 960.6 7315.7 9601.5 9728.2 10473.0 10531.2 400868.0 405297.8 405755.0 407007.0 407105.0 82465.6 83537.6 84264.2 86223.0 87421.0 947.1 951.4 955.5 977.9 978.1 15047.8 16174.5 16366.9 16463.5 16530.5 38907.4 40156.2 40623.4 40965.2 41400.6 49026.3 51852.5 52246.5 52770.0 53769.2 4849.7 5278.7 6951.1 7674.3 7932.6 9760.0 11999.5 12006.5 12045.1 12069.9 9798.4 9809.4 10193.3 10194.5 10571.0 9855.2 9858.4 10081.9 10218.9 10601.7 10014.5 10131.8 10307.7 10313.5 10490.0 7559.4 7683.6 7720.8 7729.8 7753.5 9876.9 9941.0 10098.6 10171.3 10318.4 23:13:25 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | [#3] mootools.html Cycles:180 Average:5174.41 Median:5370.69 stddev:2912.51 (54.2%) stddev-sans-first:2905.84 23:13:25 INFO - PROCESS | 30468 | Values: 1262.6 1375.2 1412.0 1491.4 1699.1 6778.1 7807.5 8081.2 8109.8 8128.9 7761.5 7935.8 7946.8 7947.8 7948.0 2106.1 2132.4 2133.1 2135.2 2135.8 2158.4 2189.2 2208.9 2210.7 2212.2 2179.5 2200.1 2208.4 2211.5 2212.8 2129.4 2136.4 2141.7 2144.2 2145.1 2107.7 2155.6 2157.2 2157.7 2161.3 7738.9 7856.9 7877.0 7955.6 8049.9 4619.6 4734.5 4735.7 4739.5 4742.8 2896.9 2916.5 2981.0 3002.8 3024.2 884.6 896.7 897.5 909.6 912.2 10741.4 10831.9 10833.6 10872.2 10887.4 4008.9 4112.4 4261.0 4281.9 4287.6 8448.9 8497.2 8528.1 8538.6 8558.0 4631.0 4634.0 4634.7 4638.9 4648.4 3750.6 4166.7 4277.8 4292.6 4306.5 3475.6 3514.6 3573.6 3616.2 3618.7 1043.1 1047.9 1051.3 1053.7 1057.8 764.7 800.2 839.6 843.8 850.3 5042.8 5265.5 5280.0 5310.5 5348.4 865.7 889.8 891.7 905.2 907.4 3648.3 3659.5 3765.7 3845.0 3875.6 9809.3 9826.2 9898.7 9944.8 9948.9 9727.5 9733.1 9745.8 9791.6 9815.9 6939.2 7242.5 7285.6 7297.7 7519.6 5330.6 5393.0 5408.6 5481.8 5549.8 9159.1 9163.2 9172.0 9185.1 9238.0 8499.0 8854.7 8867.6 9222.6 9236.4 6093.5 6750.7 6901.9 7089.9 7369.2 7416.6 7677.3 7749.1 7750.4 7756.5 6862.6 6919.6 6985.3 7013.6 7094.8 6698.5 6714.0 6792.8 6900.0 6940.2 5842.1 5846.6 6187.5 6329.8 6401.8 4606.5 4618.4 4625.6 4638.7 4657.0 4622.5 4670.8 4677.6 4724.0 4729.0 23:13:25 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | [#4] prototype.html Cycles:180 Average:4226.93 Median:4852.31 stddev:1214.48 (25.0%) stddev-sans-first:1181.59 23:13:25 INFO - PROCESS | 30468 | Values: 300.5 312.1 314.1 319.3 320.8 4857.7 4875.9 4878.7 4882.6 4901.6 4794.3 4822.6 4829.7 4845.8 4846.9 3644.2 3728.5 3744.6 3823.7 3872.7 3802.7 3819.3 3844.2 3868.7 3869.6 3610.1 3797.7 3797.9 3806.6 3813.6 3643.4 3769.8 3770.0 3781.6 3812.6 3347.7 3365.2 3372.2 3379.4 3382.9 4687.9 4707.9 4710.4 4713.7 4723.4 4284.5 4358.9 4371.7 4381.3 4390.1 5038.8 5051.7 5056.8 5061.8 5075.8 3709.6 3717.3 3733.9 3737.8 3740.8 5144.9 5250.8 5268.8 5269.7 5275.9 3746.6 3752.5 3757.2 3765.9 3772.8 3822.6 3830.4 3831.2 3847.0 3852.6 4345.1 4349.3 4350.7 4353.8 4356.0 4894.0 5013.9 5016.9 5022.6 5030.3 1301.2 1314.9 1319.1 1320.7 1321.0 862.9 863.8 891.7 898.9 900.9 4346.3 4362.6 4491.8 4493.3 4535.3 5155.5 5192.9 5199.2 5199.7 5208.6 4245.4 4451.1 4456.6 4475.8 4486.5 2714.6 2738.1 2742.1 2761.0 2764.5 4889.5 4922.9 4929.9 4940.7 4978.6 5086.8 5359.2 5360.5 5363.7 5375.1 4906.3 4906.4 4917.2 4918.7 4972.0 5240.5 5245.0 5270.1 5296.8 5303.4 4940.9 5157.1 5164.9 5172.0 5212.6 4911.0 4930.5 4933.4 4953.3 4973.0 3736.9 3746.2 3746.9 3748.5 3751.8 5136.5 5193.7 5252.7 5257.4 5301.9 5037.5 5048.7 5056.5 5056.9 5108.8 5046.6 5048.5 5108.3 5125.5 5133.1 4768.4 4901.9 4972.5 4987.6 4995.8 4945.4 5069.4 5077.7 5082.8 5096.6 4993.4 5000.2 5003.6 5004.2 5009.2 23:13:25 INFO - PROCESS | 30468 | 23:13:25 INFO - PROCESS | 30468 | [#5] yui.html Cycles:180 Average:18767.20 Median:586.99 stddev:28102.74 (4787.6%) stddev-sans-first:28148.61 23:13:25 INFO - PROCESS | 30468 | Values: 636.6 709.8 735.0 755.6 768.7 12994.7 13728.9 13731.4 13737.6 13755.7 12696.2 12926.4 12934.6 13084.5 13104.7 776.4 794.5 795.6 796.9 798.4 618.9 637.4 772.3 794.6 798.2 836.9 840.9 841.2 842.3 842.8 646.2 838.8 839.2 839.8 839.9 586.2 600.7 600.8 604.7 606.1 13482.5 13497.5 13506.9 13514.7 13524.3 12709.9 13193.2 13217.9 13424.5 13502.0 11296.1 11301.7 11312.2 11583.4 11772.5 3317.0 3372.1 3375.0 3474.0 3547.9 62091.7 62242.0 62271.7 62480.4 64628.7 9132.7 9198.0 9255.6 9276.5 9308.0 17246.8 17872.9 19529.8 19560.1 19561.5 6724.8 6878.1 6903.8 6919.6 7130.4 3708.6 3765.7 3842.7 3860.5 3874.1 3407.6 3618.9 3626.7 3650.8 3652.4 593.7 601.3 602.1 603.2 621.0 545.7 579.4 587.7 597.2 603.3 7590.7 8062.7 8203.1 8461.3 8544.9 509.3 522.7 530.9 605.5 623.8 3837.5 3950.1 3974.1 4011.9 4107.8 109535.0 110832.0 110932.4 112361.4 115470.0 95130.5 95163.0 95891.5 96013.0 97277.0 62224.4 76244.9 76692.0 79343.2 79907.0 7216.9 7460.9 7566.5 7609.5 7617.5 46596.3 46856.8 48199.8 48803.3 49107.3 66609.0 70830.3 71932.7 72397.3 73063.0 10186.5 10205.5 10632.3 10698.3 10997.8 11614.2 12098.3 12410.8 12543.6 12664.5 10493.7 10928.8 11144.9 11268.2 11475.1 11026.3 11339.6 11348.3 11611.0 11732.5 10603.9 10774.6 11222.7 11236.9 11561.9 8744.6 8937.2 9098.0 9200.1 9362.4 9378.2 9647.5 9657.7 9805.6 9853.1 23:13:25 INFO - PROCESS | 30468 | -------- Summary: end -------- 23:13:25 INFO - PROCESS | 30468 | 23:13:26 INFO - TEST-INFO | 30468: exit 0 23:13:26 INFO - TEST-OK | dromaeo_css | took 1120328ms 23:13:26 INFO - TEST-START | kraken 23:13:26 INFO - operating with platform_type : linux_ 23:13:26 INFO - Initialising browser for kraken test... 23:13:26 INFO - TEST-INFO | started process 30662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8cGNCl/profile http://localhost:53269/getInfo.html) 23:13:30 INFO - PROCESS | 30662 | __metrics Screen width/height:1600/1200 23:13:30 INFO - PROCESS | 30662 | colorDepth:24 23:13:30 INFO - PROCESS | 30662 | Browser inner width/height: 1024/697 23:13:30 INFO - PROCESS | 30662 | __metrics 23:13:31 INFO - PROCESS | 30662 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:13:32 INFO - TEST-INFO | 30662: exit 0 23:13:32 INFO - Browser initialized. 23:13:32 INFO - Running cycle 1/1 for kraken test... 23:13:32 INFO - TEST-INFO | started process 30743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8cGNCl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:44 INFO - PROCESS | 30743 | RSS: Main: 158588928 23:13:44 INFO - PROCESS | 30743 | 23:13:47 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53269/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:48 INFO - PROCESS | 30743 | RSS: Main: 216932352 23:13:48 INFO - PROCESS | 30743 | 23:13:50 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53269/tests/kraken/driver.html?testName=audio-dft) 23:13:51 INFO - PROCESS | 30743 | RSS: Main: 204902400 23:13:51 INFO - PROCESS | 30743 | 23:13:54 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53269/tests/kraken/driver.html?testName=audio-fft) 23:13:55 INFO - PROCESS | 30743 | RSS: Main: 271433728 23:13:55 INFO - PROCESS | 30743 | 23:13:57 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53269/tests/kraken/driver.html?testName=audio-oscillator) 23:13:58 INFO - PROCESS | 30743 | RSS: Main: 181833728 23:13:58 INFO - PROCESS | 30743 | 23:14:00 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:00 INFO - PROCESS | 30743 | RSS: Main: 185778176 23:14:00 INFO - PROCESS | 30743 | 23:14:04 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53269/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:04 INFO - PROCESS | 30743 | RSS: Main: 221851648 23:14:04 INFO - PROCESS | 30743 | 23:14:08 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53269/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:08 INFO - PROCESS | 30743 | RSS: Main: 222552064 23:14:08 INFO - PROCESS | 30743 | 23:14:11 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53269/tests/kraken/driver.html?testName=json-parse-financial) 23:14:12 INFO - PROCESS | 30743 | RSS: Main: 222511104 23:14:12 INFO - PROCESS | 30743 | 23:14:13 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:14 INFO - PROCESS | 30743 | RSS: Main: 210554880 23:14:14 INFO - PROCESS | 30743 | 23:14:16 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53269/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:16 INFO - PROCESS | 30743 | RSS: Main: 216309760 23:14:16 INFO - PROCESS | 30743 | 23:14:19 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:19 INFO - PROCESS | 30743 | RSS: Main: 213553152 23:14:19 INFO - PROCESS | 30743 | 23:14:22 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:23 INFO - PROCESS | 30743 | RSS: Main: 223936512 23:14:23 INFO - PROCESS | 30743 | 23:14:26 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:26 INFO - PROCESS | 30743 | RSS: Main: 224006144 23:14:26 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | Cycle 1(1): loaded http://localhost:53269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53269/tests/kraken/driver.html?testName=ai-astar) 23:14:28 INFO - PROCESS | 30743 | RSS: Main: 266813440 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | __start_tp_report 23:14:28 INFO - PROCESS | 30743 | _x_x_mozilla_page_load 23:14:28 INFO - PROCESS | 30743 | _x_x_mozilla_page_load_details 23:14:28 INFO - PROCESS | 30743 | |i|pagename|runs| 23:14:28 INFO - PROCESS | 30743 | |0;ai-astar;103;112;112;112;112;112;111;111;111;111 23:14:28 INFO - PROCESS | 30743 | |1;audio-beat-detection;150;122;124;177;123;124;149;121;184;120 23:14:28 INFO - PROCESS | 30743 | |2;audio-dft;163;162;163;161;161;163;161;161;162;162 23:14:28 INFO - PROCESS | 30743 | |3;audio-fft;75;77;77;119;76;77;76;75;108;75 23:14:28 INFO - PROCESS | 30743 | |4;audio-oscillator;84;85;115;86;87;86;111;86;86;124 23:14:28 INFO - PROCESS | 30743 | |5;imaging-gaussian-blur;117;117;118;117;119;117;117;117;117;117 23:14:28 INFO - PROCESS | 30743 | |6;imaging-darkroom;147;146;146;147;146;146;146;148;147;146 23:14:28 INFO - PROCESS | 30743 | |7;imaging-desaturate;95;95;94;95;96;96;96;96;96;95 23:14:28 INFO - PROCESS | 30743 | |8;json-parse-financial;64;64;63;64;62;63;64;63;64;64 23:14:28 INFO - PROCESS | 30743 | |9;json-stringify-tinderbox;65;65;64;65;65;65;65;66;65;66 23:14:28 INFO - PROCESS | 30743 | |10;stanford-crypto-aes;82;86;77;78;87;80;77;85;77;83 23:14:28 INFO - PROCESS | 30743 | |11;stanford-crypto-ccm;133;127;135;128;127;138;145;139;164;140 23:14:28 INFO - PROCESS | 30743 | |12;stanford-crypto-pbkdf2;177;174;171;177;168;170;171;168;171;167 23:14:28 INFO - PROCESS | 30743 | |13;stanford-crypto-sha256-iterative;69;68;69;67;67;70;67;69;67;67 23:14:28 INFO - PROCESS | 30743 | __end_tp_report 23:14:28 INFO - PROCESS | 30743 | __start_cc_report 23:14:28 INFO - PROCESS | 30743 | _x_x_mozilla_cycle_collect,1919 23:14:28 INFO - PROCESS | 30743 | __end_cc_report 23:14:28 INFO - PROCESS | 30743 | __startTimestamp1467699268683__endTimestamp 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | ------- Summary: start ------- 23:14:28 INFO - PROCESS | 30743 | Number of tests: 14 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.75 (2.5%) stddev-sans-first:0.53 23:14:28 INFO - PROCESS | 30743 | Values: 103.0 112.0 112.0 112.0 112.0 112.0 111.0 111.0 111.0 111.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:136.50 stddev:24.42 (17.9%) stddev-sans-first:25.60 23:14:28 INFO - PROCESS | 30743 | Values: 150.0 122.0 124.0 177.0 123.0 124.0 149.0 121.0 184.0 120.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 23:14:28 INFO - PROCESS | 30743 | Values: 163.0 162.0 163.0 161.0 161.0 163.0 161.0 161.0 162.0 162.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:16.04 (21.1%) stddev-sans-first:16.72 23:14:28 INFO - PROCESS | 30743 | Values: 75.0 77.0 77.0 119.0 76.0 77.0 76.0 75.0 108.0 75.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:86.00 stddev:15.30 (17.8%) stddev-sans-first:15.70 23:14:28 INFO - PROCESS | 30743 | Values: 84.0 85.0 115.0 86.0 87.0 86.0 111.0 86.0 86.0 124.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 23:14:28 INFO - PROCESS | 30743 | Values: 117.0 117.0 118.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:14:28 INFO - PROCESS | 30743 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 148.0 147.0 146.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 23:14:28 INFO - PROCESS | 30743 | Values: 95.0 95.0 94.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 23:14:28 INFO - PROCESS | 30743 | Values: 64.0 64.0 63.0 64.0 62.0 63.0 64.0 63.0 64.0 64.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 23:14:28 INFO - PROCESS | 30743 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 65.0 66.0 65.0 66.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:82.50 stddev:3.94 (4.8%) stddev-sans-first:4.17 23:14:28 INFO - PROCESS | 30743 | Values: 82.0 86.0 77.0 78.0 87.0 80.0 77.0 85.0 77.0 83.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:138.50 stddev:11.08 (8.0%) stddev-sans-first:11.62 23:14:28 INFO - PROCESS | 30743 | Values: 133.0 127.0 135.0 128.0 127.0 138.0 145.0 139.0 164.0 140.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.00 stddev:3.57 (2.1%) stddev-sans-first:3.15 23:14:28 INFO - PROCESS | 30743 | Values: 177.0 174.0 171.0 177.0 168.0 170.0 171.0 168.0 171.0 167.0 23:14:28 INFO - PROCESS | 30743 | 23:14:28 INFO - PROCESS | 30743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 23:14:28 INFO - PROCESS | 30743 | Values: 69.0 68.0 69.0 67.0 67.0 70.0 67.0 69.0 67.0 67.0 23:14:28 INFO - PROCESS | 30743 | -------- Summary: end -------- 23:14:28 INFO - PROCESS | 30743 | 23:14:29 INFO - TEST-INFO | 30743: exit 0 23:14:29 INFO - TEST-OK | kraken | took 63283ms 23:14:29 INFO - SUITE-END | took 1183s 23:14:29 INFO - Completed test suite (00:19:43) 23:14:29 INFO - javascript benchmark 23:14:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.160908509277, 2632.631431599578, 2660.9068682596107, 2683.731626837315, 2687.3013016615687, 4659.277811939146, 4671.4627817800965, 4742.762861856906, 4832.081904438154, 4848.0, 4736.786844591993, 4751.809927602892, 4794.400699912511, 4805.759712014394, 4809.639277054226, 4308.849190278341, 4326.978365108186, 4381.014271788854, 4415.86752397427, 4449.443819522559, 4371.781410929457, 4454.0646464242545, 4480.731156130626, 4488.5062643109395, 4521.932171017437, 4420.049689316812, 4484.394606728082, 4495.1459222747735, 4496.5278645742055, 4523.389342438762, 4254.255505286563, 4303.978480107579, 4344.978275108604, 4383.145286669101, 4411.073674528353, 4270.914581708348, 4275.166342563201, 4315.892102697427, 4331.0255192581735, 4344.717593356453, 4739.526047395233, 4758.476567577563, 4767.046590681877, 4773.498782627808, 4786.52134786522, 4985.651004429691, 5058.519440653132, 5095.5923526118195, 5096.311997880276, 5123.923141152885, 5144.356955380577, 5147.665401748912, 5150.768215430277, 5160.948390516084, 5172.66377685453, 4804.399450068741, 4805.038992201574, 4805.879853003633, 4839.37088178538, 4846.466888642247, 5112.4120726116225, 5187.636865419385, 5229.47705229474, 5233.607479439057, 5255.02781985334, 5070.670406423571, 5083.364579427572, 5087.135187018142, 5088.618353623493, 5090.745462726923, 4980.7509624518625, 5131.0, 5142.254373115878, 5169.586433085344, 5181.81863634771, 4774.689645173053, 5020.974895125501, 5089.847304580794, 5093.745312734422, 5117.565006974374, 5100.209467532539, 5102.158143906288, 5105.897882042338, 5106.183010718267, 5149.407818100892, 4250.128723611714, 4300.161468513672, 4311.827526898952, 4334.371516130143, 4367.061081867414, 3764.6235376462137, 3785.7539259948567, 3796.677282431024, 3820.67524260441, 3829.425586162098, 4400.779961002001, 4423.800928958204, 4428.490723566767, 4428.955710442854, 4470.2177119004045, 5072.416672082684, 5151.562117220078, 5154.793808247703, 5161.148410512224, 5211.114110601206, 4369.519352871182, 4433.5788100131085, 4445.133199026159, 4446.822127114944, 4457.064016556495, 4628.375169352094, 4633.189191891473, 4634.976825115853, 4653.092646933883, 4688.156131896223, 4700.553447422626, 4711.481737008995, 4825.806967721252, 4831.106245344622, 4836.056968891033, 5086.593072554113, 5093.18509038552, 5124.256982737407, 5170.43125256214, 5185.066687996046, 4761.8333358333675, 4790.688605240648, 4791.544803243825, 4793.544613261734, 4851.078295123915, 4963.553280204799, 5019.472955339636, 5029.899402012013, 5041.924371134362, 5085.542301192911, 5117.769700363567, 5125.79496820123, 5153.969206158708, 5155.613329000415, 5206.635535512478, 4977.626677999092, 4981.476944920876, 4989.376327959005, 5010.724410157331, 5043.672161309503, 4863.659543831898, 4921.557059864629, 4922.310876477368, 5012.674176178537, 5017.924731129109, 4913.533214344631, 4916.827911023097, 4948.158813001726, 4960.032793605213, 4970.005998800182, 5003.974980125076, 5020.046191223656, 5024.221245706921, 5028.924566131438, 5062.2406639002975, 4855.975720121377, 4863.416390033219, 4883.853484395474, 4899.828506002415, 4910.8772280693265], "value": 4694.504341753365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.3587036324861, 587.806024012076, 589.2928485817018, 594.4501336263954, 604.6976511744128, 27151.864240678795, 39432.802835985814, 41172.382414263775, 41266.17467650645, 44602.55397446024, 41210.17579648405, 41711.0, 41734.0, 41798.37302440458, 41946.0, 7813.101493328269, 7958.880616790752, 7967.840643187133, 7996.320312773421, 7999.240072193133, 7876.881846772274, 7958.084820245659, 7960.402969777261, 7973.083095444011, 7997.720079797208, 7995.000624921885, 8036.116027237029, 8038.075621303567, 8044.959775201145, 8051.0, 7969.083555391147, 7996.160403157643, 8014.118446970829, 8016.318612917879, 8016.879746803803, 7789.221077892222, 7873.330766884822, 7880.290773830326, 7884.053913530356, 7889.684412623488, 39796.20407591832, 40155.39766903499, 40180.0, 40215.59784402177, 40247.0, 3067.2791893904914, 3192.393445245396, 3196.408664397094, 3502.5096486491657, 3776.055986003499, 30290.394192116255, 30530.616312092206, 30690.693093069007, 31051.22371940697, 31232.531512027337, 2877.683454819968, 2899.536074228113, 2928.7364137227537, 2943.8969636062634, 2949.0, 263992.0, 264008.0, 265133.0, 265134.0, 265255.0, 32031.359372812414, 53061.46938530565, 53140.46859531355, 53206.20190697143, 53212.73393633007, 32445.0, 34495.13762155916, 34507.0, 34534.30931381408, 34636.0, 13444.395002224923, 13744.931275343759, 13750.312484375941, 13752.93123534376, 13756.587302380945, 11168.888311116785, 11363.090952723762, 11368.772624547462, 11373.658790236306, 11392.772144557062, 7918.683252669829, 7954.164812694699, 7963.243491868263, 8018.919810801934, 8037.638306276232, 3072.8309942952906, 3085.0, 3085.691430856941, 3124.734397576186, 3133.122725636825, 819.4837252530987, 888.7111688701198, 906.9773255668529, 952.2286947572488, 976.0776066616979, 28090.2977425566, 28651.856740716164, 28903.56644650332, 29202.269943251165, 29254.0, 932.3566738950103, 935.499507763357, 956.9664762056962, 976.829054915387, 1006.9949650251848, 14900.70198596022, 15123.16822574769, 15416.229188540528, 15615.0, 15633.530994070195, 403429.0, 453555.0, 461092.0, 742831.0, 745158.0, 51772.48227517752, 52160.0, 52278.738606306724, 52346.0, 52359.214611780095, 1099.7580532282884, 1139.3334899083964, 1179.0449735714099, 1185.436917464215, 1207.034372501995, 27293.590596140675, 32025.519617205293, 32087.358252834347, 32107.073575584604, 32133.36435136808, 47925.76037119792, 49111.50888491069, 49123.75438122787, 49169.2624610624, 49199.0, 364407.0, 370613.0, 371262.0, 371752.0, 373070.0, 22707.0, 25405.0, 25778.226653200432, 26082.087126950464, 26308.73691263063, 42316.576834231266, 42689.14621707611, 43095.35356969711, 43339.349909750745, 43410.56589434065, 36100.81949590235, 36511.45232821563, 36869.0, 37408.81295593505, 37741.62258377381, 36151.45772813463, 37243.44134837925, 37583.62416375801, 38810.417843731804, 40438.0, 36997.0, 37398.252034958605, 37527.624723752415, 37789.81105094457, 37935.24129517339, 31231.687683123786, 33692.74794863956, 33954.0, 34082.31835363229, 34200.82899585486, 25971.480570388863, 26218.737812621628, 26267.474650507265, 26357.20928372152, 26795.732042679323], "value": 17079.433634157278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.16384389358103, 377.3415390144197, 379.93351163546373, 387.22941346720035, 390.3188935307886, 16045.197740112992, 16744.162791860403, 17695.203715832788, 17704.468865934028, 17930.0, 10339.069483746462, 10559.26085174038, 10568.15454763619, 10603.628872989448, 10638.042576168162, 4616.307553866922, 4792.784324705397, 4983.152864013126, 5357.732113394315, 5361.571074314065, 5253.7373131343475, 5307.893842123155, 5311.176767601028, 5322.414534401232, 5344.839654810343, 5119.948800511985, 5279.736013199325, 5292.391374991887, 5407.810726624569, 5408.08062629352, 5513.751881165337, 5529.115341545374, 5544.695041772701, 5553.500184983351, 5585.58108141889, 5303.310569625963, 5325.547328477084, 5423.972880135613, 5427.267318911936, 5444.482774136451, 12218.389080545938, 12263.386830658521, 12293.0, 15805.683886322324, 21256.14975400982, 1905.3140869287045, 2026.9391918242477, 2132.7334083239593, 2235.251190851067, 2268.875211863347, 9298.581563829577, 9332.160105590461, 9805.509724513817, 9816.558254878548, 12840.587535371102, 1706.2833609883878, 1756.4379398592455, 1762.7972783129976, 1768.9911550442293, 1781.4477511971331, 70624.0, 70801.6459917697, 71115.64442177756, 71517.6424117876, 74166.25833741702, 10009.799804003878, 10134.341267817568, 10165.390076595428, 10272.0, 10655.254132210826, 13325.800112998313, 13416.731665366638, 13507.189568625718, 13521.121127126706, 13608.319584020957, 7334.596597187099, 7367.5211111277595, 7398.667059982314, 7472.14070381913, 7540.359069479046, 7150.213476517579, 7150.96424517874, 7183.928160718326, 7260.128784545888, 7299.5620262784405, 4429.202743506135, 4430.0, 4478.977605112019, 4514.45826500822, 4575.107853968444, 1815.5188874948149, 1869.1775618727715, 1904.0, 1923.4998900286027, 1952.6094781043848, 804.9114597394282, 865.6277800545699, 913.6117150211134, 926.8841394825647, 943.4952300519326, 17176.65646687084, 17313.2209050593, 17886.910565447088, 18095.63808723818, 18114.456566303033, 858.5621333120154, 863.9891327147253, 865.9956700216459, 877.6006916852816, 960.596549449233, 7315.743948961761, 9601.519924003911, 9728.221742260603, 10473.0, 10531.210159238088, 400868.0, 405297.84106476855, 405755.0, 407007.0, 407105.0, 82465.58767206126, 83537.58231208926, 84264.15735842686, 86223.0, 87421.0, 947.1097168661436, 951.3863558005048, 955.5222388805597, 977.8582105594792, 978.0512902484578, 15047.849521504644, 16174.514764557081, 16366.918165409097, 16463.506094816694, 16530.504084877473, 38907.416388754755, 40156.1968760629, 40623.39064914088, 40965.18069638531, 41400.58599414088, 49026.264606031655, 51852.481475184766, 52246.47753522416, 52770.0, 53769.19346209888, 4849.660523763303, 5278.656887302313, 6951.131108611424, 7674.330343766783, 7932.6430310635005, 9760.0, 11999.520019199133, 12006.519739210684, 12045.09661775388, 12069.879301206876, 9798.363106398061, 9809.41143531362, 10193.286469947032, 10194.541245644112, 10570.995755403224, 9855.240532650869, 9858.408495490294, 10081.89918100839, 10218.897811021794, 10601.734956626146, 10014.499275036365, 10131.79736405253, 10307.742306442398, 10313.484325783531, 10489.971218958817, 7559.357454616419, 7683.615819209129, 7720.8455830884195, 7729.806754831175, 7753.457257991887, 9876.85184722244, 9940.950295248478, 10098.646547370807, 10171.288009839536, 10318.380897146195], "value": 8165.151626177002, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.621213635909, 1375.2092546785595, 1412.0257022654368, 1491.395984626226, 1699.1419333236722, 6778.051072849798, 7807.5315481071175, 8081.232282933127, 8109.837803243931, 8128.878066829002, 7761.45669803114, 7935.801604959879, 7946.801329966754, 7947.801304967379, 7948.0, 2106.115431518762, 2132.402927180392, 2133.0827744070043, 2135.1886283212357, 2135.829133669303, 2158.4495953531905, 2189.2337681811396, 2208.933731988043, 2210.7015552900393, 2212.203606701586, 2179.455136215946, 2200.0539767899795, 2208.436848603612, 2211.5355775287208, 2212.7565967743535, 2129.371835308588, 2136.39112852837, 2141.6787481877686, 2144.1637761273037, 2145.0668959002883, 2107.725995620575, 2155.5904378168257, 2157.244964262511, 2157.7410710714657, 2161.275972549198, 7738.922610773877, 7856.882146767803, 7876.960615196945, 7955.641996110131, 8049.9195008049755, 4619.630429565626, 4734.479207287196, 4735.668503204777, 4739.502352252998, 4742.810287588492, 2896.884124635012, 2916.518774402221, 2980.9850950745326, 3002.789804713671, 3024.2439390152463, 884.593087179898, 896.7444278380631, 897.4929165021807, 909.5725009245645, 912.1972664055588, 10741.409222492759, 10831.891681083245, 10833.566657333697, 10872.18458615607, 10887.401192934385, 4008.939865902014, 4112.383142528644, 4260.957390426118, 4281.871543853689, 4287.6355509782015, 8448.915510844936, 8497.192766687154, 8528.104549022388, 8538.615762290712, 8557.973043234852, 4631.02748422835, 4634.0, 4634.675572709878, 4638.8608341749805, 4648.418947631546, 3750.624937506282, 4166.729162604421, 4277.786110694515, 4292.59220374064, 4306.547812479645, 3475.565554305712, 3514.63096374877, 3573.5711714593895, 3616.1863580694135, 3618.7105031597407, 1043.0664555223034, 1047.874255089379, 1051.3008849115406, 1053.6680945502142, 1057.7778666480126, 764.7399884039453, 800.1718221640574, 839.6179738219096, 843.8185790055168, 850.3239924260228, 5042.773075211624, 5265.526102650703, 5279.973600131974, 5310.548603368757, 5348.411674715778, 865.6970060478908, 889.8175873945826, 891.6567121658209, 905.180811365715, 907.4328544659588, 3648.288583726148, 3659.524261845996, 3765.661090501868, 3844.961550384516, 3875.5930627284292, 9809.264305177141, 9826.164775993977, 9898.653547125816, 9944.751381215383, 9948.900510994943, 9727.464989425507, 9733.124018838338, 9745.756356091155, 9791.559379827782, 9815.852762208573, 6939.167299923941, 7242.529235599669, 7285.599292038883, 7297.70809167638, 7519.624018799148, 5330.573554115739, 5392.973035134956, 5408.5673146149, 5481.835544933659, 5549.805756798492, 9159.129882661136, 9163.175314221751, 9171.954140229256, 9185.127412895765, 9238.0, 8499.0, 8854.690085846965, 8867.64529418816, 9222.631094756134, 9236.399634023766, 6093.5375509878195, 6750.6624668767345, 6901.861962760616, 7089.929100708927, 7369.152547457111, 7416.592087435243, 7677.30904218623, 7749.147593764568, 7750.379969602531, 7756.534607923542, 6862.622555759282, 6919.6194209316955, 6985.301469852974, 7013.649317534205, 7094.787156385317, 6698.531102822755, 6714.026466162477, 6792.76225332111, 6900.0, 6940.236573976959, 5842.094475356326, 5846.5615078870105, 6187.535934804818, 6329.810105696836, 6401.775937842153, 4606.539346065367, 4618.399608050931, 4625.583697467244, 4638.744869032235, 4657.045305712389, 4622.537746225485, 4670.78981445829, 4677.602403795716, 4724.0, 4729.030548737569], "value": 4147.906008952941, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.54617527533424, 312.09959267513216, 314.098537198241, 319.27524519341097, 320.76904628667353, 4857.684250523718, 4875.878103047426, 4878.682885612433, 4882.633802464811, 4901.6078713702955, 4794.256890182019, 4822.614190864731, 4829.681752758678, 4845.830395936143, 4846.927296090562, 3644.234710710754, 3728.5152930119184, 3744.569374521924, 3823.6941044716355, 3872.7095467839886, 3802.676772474343, 3819.2934307153264, 3844.2311537692435, 3868.729188956774, 3869.6323849234277, 3610.115521697188, 3797.715171362145, 3797.886063418102, 3806.6193380661853, 3813.5805061443357, 3643.362411577963, 3769.754965927206, 3770.0, 3781.640744129303, 3812.5806161322234, 3347.6652334766572, 3365.1923538350866, 3372.1738174147245, 3379.4423920053164, 3382.949255761141, 4687.929681054787, 4707.882302942419, 4710.3641008463765, 4713.740744259065, 4723.385959825201, 4284.464441944757, 4358.869233922987, 4371.650267978554, 4381.298992161239, 4390.1219756048595, 5038.84883453497, 5051.676228934694, 5056.772445239936, 5061.772220250061, 5075.847724568269, 3709.5919448860604, 3717.3494638438165, 3733.9171640224304, 3737.794421306827, 3740.7942563159017, 5144.871378215537, 5250.81622143227, 5268.789248430058, 5269.657472264329, 5275.894482110336, 3746.550413950343, 3752.5309336332957, 3757.1546402059316, 3765.86819461323, 3772.811359432072, 3822.636849499349, 3830.3871380578976, 3831.233753249361, 3847.0, 3852.5569559500454, 4345.130973805251, 4349.3041113421705, 4350.6736994725525, 4353.847615333511, 4355.956440435555, 4893.975530122327, 5013.874653133628, 5016.949830501721, 5022.6233032522705, 5030.2957585938, 1301.2387753164505, 1314.921104733719, 1319.103009953241, 1320.650027742649, 1320.9603711888658, 862.8964524257129, 863.8013256950936, 891.7235656946367, 898.9190972812478, 900.9369344145847, 4346.304941072984, 4362.578768783355, 4491.752953587584, 4493.303537951622, 4535.297028960516, 5155.458676838953, 5192.8961420771375, 5199.194124910569, 5199.7140157291715, 5208.557272631793, 4245.448091748053, 4451.08752705701, 4456.62118719906, 4475.7985890635, 4486.506484286726, 2714.5792402177694, 2738.1101142128887, 2742.067696983035, 2760.9585856212175, 2764.4885696146275, 4889.486603906538, 4922.926156107661, 4929.926051109236, 4940.678855874428, 4978.551930326215, 5086.796528138833, 5359.249705041298, 5360.517553420211, 5363.678179309176, 5375.139977603565, 4906.2640603909695, 4906.411230652345, 4917.164082106051, 4918.655694101379, 4972.0, 5240.502152295526, 5245.0, 5270.129104167965, 5296.761645726028, 5303.443138470405, 4940.901181976412, 5157.097507936021, 5164.922526162186, 5171.974140129275, 5212.582993360598, 4910.950890491049, 4930.4822993586595, 4933.3719872442725, 4953.281774142802, 4973.0, 3736.925261494809, 3746.213295207928, 3746.94379584301, 3748.4564738112276, 3751.8124093795745, 5136.486351364833, 5193.662411943212, 5252.737363131904, 5257.39539952895, 5301.946980530145, 5037.471065538212, 5048.697078175322, 5056.544910958031, 5056.862206003767, 5108.795648174031, 5046.621503387188, 5048.469910659474, 5108.28484012246, 5125.513076257749, 5133.1273683473155, 4768.403949506312, 4901.90196196067, 4972.453030166751, 4987.551120399182, 4995.825146119869, 4945.381827271591, 5069.442361340323, 5077.695338279567, 5082.847514574569, 5096.643234973516, 4993.375828021497, 5000.2499625056535, 5003.624728145476, 5004.2493625956395, 5009.223570346602], "value": 3845.3931654090866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.6021236727046, 709.755134478605, 734.9783800517279, 755.6323055269966, 768.65794721349, 12994.675133121666, 13728.862711372896, 13731.382087806047, 13737.58787236382, 13755.724885502284, 12696.174748641331, 12926.35368231587, 12934.611961641142, 13084.542041028566, 13104.73790524189, 776.39441235836, 794.5471081483556, 795.5664163031133, 796.8605494038549, 798.3613109512396, 618.9102580125879, 637.3785559079906, 772.2856357868977, 794.6146119132217, 798.1579433697447, 836.9079401265856, 840.8696652018947, 841.1630427724392, 842.296682270302, 842.8187939592987, 646.1567654211252, 838.7777239031661, 839.2488722593275, 839.8068444257824, 839.9496030238145, 586.2408181405048, 600.687642425936, 600.7987324246383, 604.7218279591393, 606.0696830365412, 13482.52811151605, 13497.527586534523, 13506.86493135066, 13514.729705405935, 13524.323783810869, 12709.872901270961, 13193.20840749558, 13217.867821321759, 13424.530141445002, 13502.0, 11296.096312295078, 11301.717457063556, 11312.151588630886, 11583.36291503967, 11772.470238839272, 3317.0, 3372.0558243691808, 3374.96625033749, 3474.0, 3547.8935631930826, 62091.689541552456, 62242.0, 62271.68864155695, 62480.37519624791, 64628.67685661636, 9132.726018219464, 9197.95401023004, 9255.629774809067, 9276.489793061312, 9308.0, 17246.82753172452, 17872.91063544674, 19529.8047019528, 19560.119794609276, 19561.510962226057, 6724.7646332378135, 6878.105846239957, 6903.827404314932, 6919.550229235084, 7130.429565634737, 3708.592054873962, 3765.6987441004653, 3842.6733727632904, 3860.517435320585, 3874.050857539921, 3407.6421975692197, 3618.9276214475562, 3626.673599376069, 3650.780953142767, 3652.433872749728, 593.6823799267371, 601.338527619615, 602.0607851751195, 603.1646170054419, 620.996895015522, 545.7053191276746, 579.4061087385379, 587.7325816753367, 597.1878245585999, 603.3212635784743, 7590.658420371096, 8062.677492900336, 8203.113283944725, 8461.323094152453, 8544.871826922601, 509.29462694168103, 522.7281813456981, 530.8911673107003, 605.5255452972027, 623.834683808791, 3837.520309961255, 3950.0914789598555, 3974.145558704892, 4011.919761604752, 4107.835686572504, 109535.0, 110832.0, 110932.44533777279, 112361.4381928085, 115470.0, 95130.52434737782, 95163.0, 95891.52054239684, 96013.0, 97277.0, 62224.37775622276, 76244.85632715514, 76692.0, 79343.20656793474, 79907.0, 7216.9278307216255, 7460.888086678596, 7566.508176968479, 7609.505382150142, 7617.5048621839405, 46596.30105548487, 46856.7657161712, 48199.75900120477, 48803.26795098005, 49107.26339104845, 66609.0, 70830.29169708237, 71932.72773631099, 72397.27602723906, 73063.0, 10186.490675466346, 10205.540750666089, 10632.30889992148, 10698.304610200312, 10997.780044399227, 11614.247821144292, 12098.334591597546, 12410.75178496407, 12543.623691289276, 12664.493420263454, 10493.737656558342, 10928.836067459153, 11144.944275278573, 11268.211225214156, 11475.139364547525, 11026.338419694845, 11339.603113890975, 11348.262362946381, 11611.0, 11732.472038758448, 10603.946980265358, 10774.569017239537, 11222.719432014264, 11236.887631123584, 11561.88438115608, 8744.562771861509, 8937.240334571634, 9097.954510227406, 9200.125988031126, 9362.438253704799, 9378.249740020918, 9647.469389183661, 9657.71026869195, 9805.559699636866, 9853.06395892389], "value": 6660.235566388625, "unit": "score"}], "name": "dromaeo_css", "value": 6412.918544338869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 124.0, 177.0, 123.0, 124.0, 149.0, 121.0, 184.0, 120.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 161.0, 161.0, 163.0, 161.0, 161.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 119.0, 76.0, 77.0, 76.0, 75.0, 108.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 115.0, 86.0, 87.0, 86.0, 111.0, 86.0, 86.0, 124.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 62.0, 63.0, 64.0, 63.0, 64.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 77.0, 78.0, 87.0, 80.0, 77.0, 85.0, 77.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 127.0, 135.0, 128.0, 127.0, 138.0, 145.0, 139.0, 164.0, 140.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 171.0, 177.0, 168.0, 170.0, 171.0, 168.0, 171.0, 167.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 67.0, 67.0, 70.0, 67.0, 69.0, 67.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1536.5, "alertThreshold": 2.0}]} 23:14:29 INFO - Return code: 0 23:14:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:14:29 INFO - # TBPL SUCCESS # 23:14:29 INFO - Running post-action listener: _resource_record_post_action 23:14:29 INFO - ##### 23:14:29 INFO - ##### Finished run-tests step (success) 23:14:29 INFO - ##### 23:14:29 INFO - Running post-run listener: _resource_record_post_run 23:14:30 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514826240; Read time: 16; Write time: 367808 23:14:30 INFO - TinderboxPrint: CPU usage
12.9% 23:14:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 23:14:30 INFO - TinderboxPrint: I/O write bytes / time
514,826,240 / 367,808 23:14:30 INFO - TinderboxPrint: CPU idle
8,337.8 (87.0%) 23:14:30 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 23:14:30 INFO - TinderboxPrint: Swap in / out
0 / 0 23:14:30 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120082432; Read time: 0; Write time: 89300 23:14:30 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288391168; Read time: 0; Write time: 175504 23:14:30 INFO - Running post-run listener: _upload_blobber_files 23:14:30 INFO - Blob upload gear active. 23:14:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:14:30 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 23:14:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:14:31 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:14:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:14:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:31 INFO - (blobuploader) - INFO - Done attempting. 23:14:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:14:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:32 INFO - (blobuploader) - INFO - Done attempting. 23:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:36 INFO - (blobuploader) - INFO - Done attempting. 23:14:36 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:36 INFO - Return code: 0 23:14:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:14:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d12b01149a1bce1b4b51545e4f9950c57dcfd2eb67500fdf9e1486bb9a573f36b1567bcc0f46f914c17150790e0cf8ba31f3f7e2b8f334dab8dfd5ccdfddb238", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/97a57a5815773d7c1e59f05d01df1f8b9fe1c7c6fb9696c3c6fc9b211d6c19cae2b2afc6e23a1b21a31e8220a71706e69299c399388827e8aac484b905d13bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7d55cb91b23c8771c13dc02cc1cce6d96317e15c6c9a0f6f498fed8019c9d95f3ee5163370572ae2847241a272da228589d2fa1d8cbea946b31043a70962a3e"} 23:14:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:14:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:14:36 INFO - Contents: 23:14:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d12b01149a1bce1b4b51545e4f9950c57dcfd2eb67500fdf9e1486bb9a573f36b1567bcc0f46f914c17150790e0cf8ba31f3f7e2b8f334dab8dfd5ccdfddb238", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/97a57a5815773d7c1e59f05d01df1f8b9fe1c7c6fb9696c3c6fc9b211d6c19cae2b2afc6e23a1b21a31e8220a71706e69299c399388827e8aac484b905d13bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7d55cb91b23c8771c13dc02cc1cce6d96317e15c6c9a0f6f498fed8019c9d95f3ee5163370572ae2847241a272da228589d2fa1d8cbea946b31043a70962a3e"} 23:14:36 INFO - Running post-run listener: copy_logs_to_upload_dir 23:14:36 INFO - Copying logs to upload dir... 23:14:36 INFO - mkdir: /builds/slave/test/build/upload/logs 23:14:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.941606 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-04 23:14:35.220505) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 23:14:35.224473) ========= 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-1467695884.920819-1460794285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d12b01149a1bce1b4b51545e4f9950c57dcfd2eb67500fdf9e1486bb9a573f36b1567bcc0f46f914c17150790e0cf8ba31f3f7e2b8f334dab8dfd5ccdfddb238", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/97a57a5815773d7c1e59f05d01df1f8b9fe1c7c6fb9696c3c6fc9b211d6c19cae2b2afc6e23a1b21a31e8220a71706e69299c399388827e8aac484b905d13bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7d55cb91b23c8771c13dc02cc1cce6d96317e15c6c9a0f6f498fed8019c9d95f3ee5163370572ae2847241a272da228589d2fa1d8cbea946b31043a70962a3e"} build_url:https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/B0BSUnYoQtKTCjo8xS99lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d12b01149a1bce1b4b51545e4f9950c57dcfd2eb67500fdf9e1486bb9a573f36b1567bcc0f46f914c17150790e0cf8ba31f3f7e2b8f334dab8dfd5ccdfddb238", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/97a57a5815773d7c1e59f05d01df1f8b9fe1c7c6fb9696c3c6fc9b211d6c19cae2b2afc6e23a1b21a31e8220a71706e69299c399388827e8aac484b905d13bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7d55cb91b23c8771c13dc02cc1cce6d96317e15c6c9a0f6f498fed8019c9d95f3ee5163370572ae2847241a272da228589d2fa1d8cbea946b31043a70962a3e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 23:14:35.249378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 23:14:35.249675) ========= 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-1467695884.920819-1460794285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 23:14:35.334992) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 23:14:35.335321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 23:14:35.335603) ========= ========= Total master_lag: 0.19 =========