builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1467630798.26 results: success (0) buildid: 20160704013020 builduid: 02dd44b6e432459984e9a259e0a97445 revision: 55eb13faa8e016818d8fd96e6e30e3fb89dd0af7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.262665) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.263750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.264495) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.310950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.311260) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 04:13:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-07-04 04:13:19 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.400184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.400567) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023249 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.451140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:18.451573) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 55eb13faa8e016818d8fd96e6e30e3fb89dd0af7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 55eb13faa8e016818d8fd96e6e30e3fb89dd0af7 --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=c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 04:13:19,215 truncating revision to first 12 chars 2016-07-04 04:13:19,215 Setting DEBUG logging. 2016-07-04 04:13:19,215 attempt 1/10 2016-07-04 04:13:19,215 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/55eb13faa8e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 04:13:19,522 unpacking tar archive at: mozilla-inbound-55eb13faa8e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:19.100381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:19.100755) ========= script_repo_revision: 55eb13faa8e016818d8fd96e6e30e3fb89dd0af7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:19.101212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:19.101548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 04:13:19.112453) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-04 04:13:19.112847) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:19 INFO - MultiFileLogger online at 20160704 04:13:19 in /builds/slave/test 04:13:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:13:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:19 INFO - {'append_to_log': False, 04:13:19 INFO - 'base_work_dir': '/builds/slave/test', 04:13:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:13:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:19 INFO - 'branch': 'Mozilla-Inbound', 04:13:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:19 INFO - 'config_files': ('talos/linux_config.py',), 04:13:19 INFO - 'default_actions': ('clobber', 04:13:19 INFO - 'read-buildbot-config', 04:13:19 INFO - 'download-and-extract', 04:13:19 INFO - 'populate-webroot', 04:13:19 INFO - 'create-virtualenv', 04:13:19 INFO - 'install', 04:13:19 INFO - 'run-tests'), 04:13:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:19 INFO - 'download_minidump_stackwalk': True, 04:13:19 INFO - 'download_symbols': 'ondemand', 04:13:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:19 INFO - 'installer_path': 'installer.exe', 04:13:19 INFO - 'log_level': 'info', 04:13:19 INFO - 'log_name': 'talos', 04:13:19 INFO - 'log_to_console': True, 04:13:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:19 INFO - 'opt_config_files': (), 04:13:19 INFO - 'pip_index': False, 04:13:19 INFO - 'sps_profile': False, 04:13:19 INFO - 'sps_profile_interval': 0, 04:13:19 INFO - 'suite': 'dromaeojs', 04:13:19 INFO - 'system_bits': '32', 04:13:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:19 INFO - 'title': 'talos-linux64-ix-004', 04:13:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:19 INFO - 'use_talos_json': True, 04:13:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:19 INFO - 'work_dir': 'build'} 04:13:19 INFO - ##### 04:13:19 INFO - ##### Running clobber step. 04:13:19 INFO - ##### 04:13:19 INFO - Running pre-action listener: _resource_record_pre_action 04:13:19 INFO - Running main action method: clobber 04:13:19 INFO - rmtree: /builds/slave/test/build 04:13:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:20 INFO - Running post-action listener: _resource_record_post_action 04:13:20 INFO - ##### 04:13:20 INFO - ##### Finished clobber step (success) 04:13:20 INFO - ##### 04:13:20 INFO - ##### 04:13:20 INFO - ##### Running read-buildbot-config step. 04:13:20 INFO - ##### 04:13:20 INFO - Running pre-action listener: _resource_record_pre_action 04:13:20 INFO - Running main action method: read_buildbot_config 04:13:20 INFO - Using buildbot properties: 04:13:20 INFO - { 04:13:20 INFO - "project": "", 04:13:20 INFO - "product": "firefox", 04:13:20 INFO - "script_repo_revision": "production", 04:13:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:13:20 INFO - "repository": "", 04:13:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:13:20 INFO - "buildid": "20160704013020", 04:13:20 INFO - "pgo_build": "True", 04:13:20 INFO - "basedir": "/builds/slave/test", 04:13:20 INFO - "buildnumber": 1271, 04:13:20 INFO - "slavename": "talos-linux64-ix-004", 04:13:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:13:20 INFO - "platform": "ubuntu64_hw", 04:13:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:13:20 INFO - "branch": "mozilla-inbound", 04:13:20 INFO - "repo_path": "integration/mozilla-inbound", 04:13:20 INFO - "revision": "55eb13faa8e016818d8fd96e6e30e3fb89dd0af7", 04:13:20 INFO - "stage_platform": "linux64-pgo", 04:13:20 INFO - "builduid": "02dd44b6e432459984e9a259e0a97445", 04:13:20 INFO - "slavebuilddir": "test" 04:13:20 INFO - } 04:13:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:13:20 INFO - Running post-action listener: _resource_record_post_action 04:13:20 INFO - ##### 04:13:20 INFO - ##### Finished read-buildbot-config step (success) 04:13:20 INFO - ##### 04:13:20 INFO - ##### 04:13:20 INFO - ##### Running download-and-extract step. 04:13:20 INFO - ##### 04:13:20 INFO - Running pre-action listener: _resource_record_pre_action 04:13:20 INFO - Running main action method: download_and_extract 04:13:20 INFO - mkdir: /builds/slave/test/build/tests 04:13: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')]} 04:13:20 INFO - https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:13:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:21 INFO - Downloaded 1361 bytes. 04:13:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:21 INFO - Using the following test package requirements: 04:13:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:13:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:21 INFO - u'jsshell-linux-x86_64.zip'], 04:13:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:21 INFO - https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:22 INFO - Downloaded 24276373 bytes. 04:13:22 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'] 04:13:22 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 04:13:24 INFO - Return code: 0 04:13:24 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 04:13: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')]} 04:13:24 INFO - https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:26 INFO - Downloaded 24276373 bytes. 04:13:26 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'] 04:13:26 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 04:13:27 INFO - Return code: 0 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:30 INFO - Downloaded 14403333 bytes. 04:13:30 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'] 04:13:30 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 04:13:30 INFO - Return code: 0 04:13:30 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')]} 04:13:30 INFO - https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjvOvvIeT1-zobCVCBuK3w/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 04:13:32 INFO - Downloaded 60359123 bytes. 04:13:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:32 INFO - mkdir: /builds/slave/test/properties 04:13:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:32 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:32 INFO - Contents: 04:13:32 INFO - build_url:https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:33 INFO - Running post-action listener: _resource_record_post_action 04:13:33 INFO - Running post-action listener: set_extra_try_arguments 04:13:33 INFO - ##### 04:13:33 INFO - ##### Finished download-and-extract step (success) 04:13:33 INFO - ##### 04:13:33 INFO - ##### 04:13:33 INFO - ##### Running populate-webroot step. 04:13:33 INFO - ##### 04:13:33 INFO - Running pre-action listener: _resource_record_pre_action 04:13:33 INFO - Running main action method: populate_webroot 04:13:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:33 INFO - '--tppagecycles', 04:13:33 INFO - '7'], 04:13:33 INFO - 'tests': ['tsvgm']}}, 04:13:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:33 INFO - 'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:33 INFO - 'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['damp', 'tps']}, 04:13:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:33 INFO - 'tests': ['damp', 'tps']}, 04:13:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['dromaeo_dom']}, 04:13:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['basic_compositor_video']}, 04:13:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['a11yr', 04:13:33 INFO - 'ts_paint', 04:13:33 INFO - 'tpaint', 04:13:33 INFO - 'sessionrestore', 04:13:33 INFO - 'sessionrestore_no_auto_restore', 04:13:33 INFO - 'tabpaint']}, 04:13:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:33 INFO - 'ts_paint', 04:13:33 INFO - 'tpaint', 04:13:33 INFO - 'sessionrestore', 04:13:33 INFO - 'sessionrestore_no_auto_restore', 04:13:33 INFO - 'tabpaint']}, 04:13:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:33 INFO - 'ts_paint', 04:13:33 INFO - 'tpaint', 04:13:33 INFO - 'sessionrestore', 04:13:33 INFO - 'sessionrestore_no_auto_restore', 04:13:33 INFO - 'tabpaint']}, 04:13:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:33 INFO - 'ts_paint', 04:13:33 INFO - 'tpaint', 04:13:33 INFO - 'sessionrestore', 04:13:33 INFO - 'sessionrestore_no_auto_restore', 04:13:33 INFO - 'tabpaint']}, 04:13:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['a11yr', 04:13:33 INFO - 'ts_paint', 04:13:33 INFO - 'tpaint', 04:13:33 INFO - 'sessionrestore', 04:13:33 INFO - 'sessionrestore_no_auto_restore', 04:13:33 INFO - 'tabpaint']}, 04:13:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['a11yr', 04:13:33 INFO - 'ts_paint', 04:13:33 INFO - 'tpaint', 04:13:33 INFO - 'sessionrestore', 04:13:33 INFO - 'sessionrestore_no_auto_restore', 04:13:33 INFO - 'tabpaint']}, 04:13:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['tsvgx', 04:13:33 INFO - 'tsvgr_opacity', 04:13:33 INFO - 'tart', 04:13:33 INFO - 'tscrollx', 04:13:33 INFO - 'cart']}, 04:13:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:33 INFO - 'tsvgr_opacity', 04:13:33 INFO - 'tart', 04:13:33 INFO - 'tscrollx', 04:13:33 INFO - 'cart']}, 04:13:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:33 INFO - 'talos_options': ['--disable-e10s'], 04:13:33 INFO - 'tests': ['tp5o']}, 04:13:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:33 INFO - 'tests': ['tp5o']}, 04:13:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:33 INFO - 'talos_options': ['--disable-e10s', 04:13:33 INFO - '--xperf_path', 04:13:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:33 INFO - 'tests': ['tp5n']}, 04:13:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:33 INFO - 'talos_options': ['--xperf_path', 04:13:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:33 INFO - 'tests': ['tp5n']}}, 04:13:33 INFO - 'talos.zip': {'path': '', 04:13:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:33 INFO - Running post-action listener: _resource_record_post_action 04:13:33 INFO - ##### 04:13:33 INFO - ##### Finished populate-webroot step (success) 04:13:33 INFO - ##### 04:13:33 INFO - ##### 04:13:33 INFO - ##### Running create-virtualenv step. 04:13:33 INFO - ##### 04:13:33 INFO - Running pre-action listener: _resource_record_pre_action 04:13:33 INFO - Running main action method: create_virtualenv 04:13:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:33 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 04:13:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:33 INFO - Using real prefix '/usr' 04:13:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:35 INFO - Installing pip.................done. 04:13:35 INFO - Return code: 0 04:13:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 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 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:35 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 04:13:35 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 04:13:35 INFO - Using env: {'DISPLAY': ':0', 04:13:35 INFO - 'HOME': '/home/cltbld', 04:13:35 INFO - 'LANG': 'en_US.UTF-8', 04:13:35 INFO - 'LANGUAGE': 'en_US:en', 04:13:35 INFO - 'LOGNAME': 'cltbld', 04:13:35 INFO - 'MAIL': '/var/mail/cltbld', 04:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:35 INFO - 'MOZ_NO_REMOTE': '1', 04:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:35 INFO - 'NO_EM_RESTART': '1', 04:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:35 INFO - 'PWD': '/builds/slave/test', 04:13:35 INFO - 'SHELL': '/bin/bash', 04:13:35 INFO - 'SHLVL': '1', 04:13:35 INFO - 'TERM': 'linux', 04:13:35 INFO - 'TMOUT': '86400', 04:13:35 INFO - 'USER': 'cltbld', 04:13:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:35 INFO - '_': '/tools/buildbot/bin/python'} 04:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:35 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 04:13:35 INFO - Cleaning up... 04:13:35 INFO - Return code: 0 04:13:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 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 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:35 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 04:13:35 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 04:13:35 INFO - Using env: {'DISPLAY': ':0', 04:13:35 INFO - 'HOME': '/home/cltbld', 04:13:35 INFO - 'LANG': 'en_US.UTF-8', 04:13:35 INFO - 'LANGUAGE': 'en_US:en', 04:13:35 INFO - 'LOGNAME': 'cltbld', 04:13:35 INFO - 'MAIL': '/var/mail/cltbld', 04:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:35 INFO - 'MOZ_NO_REMOTE': '1', 04:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:35 INFO - 'NO_EM_RESTART': '1', 04:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:35 INFO - 'PWD': '/builds/slave/test', 04:13:35 INFO - 'SHELL': '/bin/bash', 04:13:35 INFO - 'SHLVL': '1', 04:13:35 INFO - 'TERM': 'linux', 04:13:35 INFO - 'TMOUT': '86400', 04:13:35 INFO - 'USER': 'cltbld', 04:13:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:35 INFO - '_': '/tools/buildbot/bin/python'} 04:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:36 INFO - Downloading/unpacking psutil>=3.1.1 04:13:36 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 04:13:36 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 04:13:36 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 04:13:36 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 04:13:36 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 04:13:36 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 04:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:38 INFO - Installing collected packages: psutil 04:13:38 INFO - Running setup.py install for psutil 04:13:38 INFO - building 'psutil._psutil_linux' extension 04:13:38 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 04:13:38 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 04:13:38 INFO - building 'psutil._psutil_posix' extension 04:13:38 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 04:13:38 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 04:13:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:38 INFO - Successfully installed psutil 04:13:38 INFO - Cleaning up... 04:13:38 INFO - Return code: 0 04:13:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:38 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 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:38 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 04:13:38 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 04:13:38 INFO - Using env: {'DISPLAY': ':0', 04:13:38 INFO - 'HOME': '/home/cltbld', 04:13:38 INFO - 'LANG': 'en_US.UTF-8', 04:13:38 INFO - 'LANGUAGE': 'en_US:en', 04:13:38 INFO - 'LOGNAME': 'cltbld', 04:13:38 INFO - 'MAIL': '/var/mail/cltbld', 04:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:38 INFO - 'MOZ_NO_REMOTE': '1', 04:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:38 INFO - 'NO_EM_RESTART': '1', 04:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:38 INFO - 'PWD': '/builds/slave/test', 04:13:38 INFO - 'SHELL': '/bin/bash', 04:13:38 INFO - 'SHLVL': '1', 04:13:38 INFO - 'TERM': 'linux', 04:13:38 INFO - 'TMOUT': '86400', 04:13:38 INFO - 'USER': 'cltbld', 04:13:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:38 INFO - '_': '/tools/buildbot/bin/python'} 04:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:38 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 04:13:38 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 04:13:38 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 04:13:38 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 04:13:38 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 04:13:38 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 04:13:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:40 INFO - Installing collected packages: mozsystemmonitor 04:13:40 INFO - Running setup.py install for mozsystemmonitor 04:13:40 INFO - Successfully installed mozsystemmonitor 04:13:40 INFO - Cleaning up... 04:13:41 INFO - Return code: 0 04:13:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:41 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 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:41 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 04:13:41 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 04:13:41 INFO - Using env: {'DISPLAY': ':0', 04:13:41 INFO - 'HOME': '/home/cltbld', 04:13:41 INFO - 'LANG': 'en_US.UTF-8', 04:13:41 INFO - 'LANGUAGE': 'en_US:en', 04:13:41 INFO - 'LOGNAME': 'cltbld', 04:13:41 INFO - 'MAIL': '/var/mail/cltbld', 04:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:41 INFO - 'MOZ_NO_REMOTE': '1', 04:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:41 INFO - 'NO_EM_RESTART': '1', 04:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:41 INFO - 'PWD': '/builds/slave/test', 04:13:41 INFO - 'SHELL': '/bin/bash', 04:13:41 INFO - 'SHLVL': '1', 04:13:41 INFO - 'TERM': 'linux', 04:13:41 INFO - 'TMOUT': '86400', 04:13:41 INFO - 'USER': 'cltbld', 04:13:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:41 INFO - '_': '/tools/buildbot/bin/python'} 04:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:41 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:41 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 04:13:41 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 04:13:41 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 04:13:41 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 04:13:41 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 04:13:41 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 04:13:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:43 INFO - warning: no files found matching '*.txt' 04:13:43 INFO - no previously-included directories found matching 'build' 04:13:43 INFO - no previously-included directories found matching 'dist' 04:13:43 INFO - no previously-included directories found matching '.git*' 04:13:43 INFO - Installing collected packages: jsonschema, functools32 04:13:43 INFO - Running setup.py install for functools32 04:13:43 INFO - warning: no files found matching '*.txt' 04:13:43 INFO - no previously-included directories found matching 'build' 04:13:43 INFO - no previously-included directories found matching 'dist' 04:13:43 INFO - no previously-included directories found matching '.git*' 04:13:43 INFO - Successfully installed jsonschema functools32 04:13:43 INFO - Cleaning up... 04:13:43 INFO - Return code: 0 04:13:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:13:43 INFO - Using env: {'DISPLAY': ':0', 04:13:43 INFO - 'HOME': '/home/cltbld', 04:13:43 INFO - 'LANG': 'en_US.UTF-8', 04:13:43 INFO - 'LANGUAGE': 'en_US:en', 04:13:43 INFO - 'LOGNAME': 'cltbld', 04:13:43 INFO - 'MAIL': '/var/mail/cltbld', 04:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:43 INFO - 'MOZ_NO_REMOTE': '1', 04:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:43 INFO - 'NO_EM_RESTART': '1', 04:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:43 INFO - 'PWD': '/builds/slave/test', 04:13:43 INFO - 'SHELL': '/bin/bash', 04:13:43 INFO - 'SHLVL': '1', 04:13:43 INFO - 'TERM': 'linux', 04:13:43 INFO - 'TMOUT': '86400', 04:13:43 INFO - 'USER': 'cltbld', 04:13:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:43 INFO - '_': '/tools/buildbot/bin/python'} 04:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:46 INFO - Downloading docopt-0.6.1.tar.gz 04:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:46 INFO - Running setup.py install for blobuploader 04:13:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:46 INFO - Running setup.py install for requests 04:13:47 INFO - Running setup.py install for docopt 04:13:47 INFO - Successfully installed blobuploader requests docopt 04:13:47 INFO - Cleaning up... 04:13:47 INFO - Return code: 0 04:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:47 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 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:47 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 04:13:47 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 04:13:47 INFO - Using env: {'DISPLAY': ':0', 04:13:47 INFO - 'HOME': '/home/cltbld', 04:13:47 INFO - 'LANG': 'en_US.UTF-8', 04:13:47 INFO - 'LANGUAGE': 'en_US:en', 04:13:47 INFO - 'LOGNAME': 'cltbld', 04:13:47 INFO - 'MAIL': '/var/mail/cltbld', 04:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:47 INFO - 'MOZ_NO_REMOTE': '1', 04:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:47 INFO - 'NO_EM_RESTART': '1', 04:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:47 INFO - 'PWD': '/builds/slave/test', 04:13:47 INFO - 'SHELL': '/bin/bash', 04:13:47 INFO - 'SHLVL': '1', 04:13:47 INFO - 'TERM': 'linux', 04:13:47 INFO - 'TMOUT': '86400', 04:13:47 INFO - 'USER': 'cltbld', 04:13:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:47 INFO - '_': '/tools/buildbot/bin/python'} 04:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:47 INFO - Running setup.py (path:/tmp/pip-O5jIA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:47 INFO - Running setup.py (path:/tmp/pip-k95lkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:47 INFO - Running setup.py (path:/tmp/pip-d0xoNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:47 INFO - Running setup.py (path:/tmp/pip-2FPcGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:47 INFO - Running setup.py (path:/tmp/pip-HEXuMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:47 INFO - Running setup.py (path:/tmp/pip-kVbPOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:47 INFO - Running setup.py (path:/tmp/pip-FLl10T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:48 INFO - Running setup.py (path:/tmp/pip-6MUapM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:48 INFO - Running setup.py (path:/tmp/pip-yZkMHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:48 INFO - Running setup.py (path:/tmp/pip-vSQ0Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:48 INFO - Running setup.py (path:/tmp/pip-IVKd8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:48 INFO - Running setup.py (path:/tmp/pip-oz1iTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:48 INFO - Running setup.py (path:/tmp/pip-ym3jRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:48 INFO - Running setup.py (path:/tmp/pip-oWYBkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:48 INFO - Running setup.py (path:/tmp/pip-wfOQ73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:48 INFO - Running setup.py (path:/tmp/pip-AMaoaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:48 INFO - Running setup.py (path:/tmp/pip-jxV2Zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:48 INFO - Running setup.py install for manifestparser 04:13:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:48 INFO - Running setup.py install for mozcrash 04:13:48 INFO - Running setup.py install for mozdebug 04:13:49 INFO - Running setup.py install for mozdevice 04:13:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Running setup.py install for mozfile 04:13:49 INFO - Running setup.py install for mozhttpd 04:13:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Running setup.py install for mozinfo 04:13:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Running setup.py install for mozInstall 04:13:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Running setup.py install for mozleak 04:13:49 INFO - Running setup.py install for mozlog 04:13:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Running setup.py install for moznetwork 04:13:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:49 INFO - Running setup.py install for mozprocess 04:13:50 INFO - Running setup.py install for mozprofile 04:13:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:50 INFO - Running setup.py install for mozrunner 04:13:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:50 INFO - Running setup.py install for mozscreenshot 04:13:50 INFO - Running setup.py install for moztest 04:13:50 INFO - Running setup.py install for mozversion 04:13:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:50 INFO - Cleaning up... 04:13:50 INFO - Return code: 0 04:13:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:50 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')]} 04:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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')]} 04:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:50 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 04:13:50 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 04:13:50 INFO - Using env: {'DISPLAY': ':0', 04:13:50 INFO - 'HOME': '/home/cltbld', 04:13:50 INFO - 'LANG': 'en_US.UTF-8', 04:13:50 INFO - 'LANGUAGE': 'en_US:en', 04:13:50 INFO - 'LOGNAME': 'cltbld', 04:13:50 INFO - 'MAIL': '/var/mail/cltbld', 04:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:50 INFO - 'MOZ_NO_REMOTE': '1', 04:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:50 INFO - 'NO_EM_RESTART': '1', 04:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:50 INFO - 'PWD': '/builds/slave/test', 04:13:50 INFO - 'SHELL': '/bin/bash', 04:13:50 INFO - 'SHLVL': '1', 04:13:50 INFO - 'TERM': 'linux', 04:13:50 INFO - 'TMOUT': '86400', 04:13:50 INFO - 'USER': 'cltbld', 04:13:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:50 INFO - '_': '/tools/buildbot/bin/python'} 04:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:50 INFO - Running setup.py (path:/tmp/pip-ylMtfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:50 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)) 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:50 INFO - Running setup.py (path:/tmp/pip-gMoUR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:50 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)) 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:50 INFO - Running setup.py (path:/tmp/pip-e3VC_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:50 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)) 04:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:51 INFO - Running setup.py (path:/tmp/pip-w4yEt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:51 INFO - Running setup.py (path:/tmp/pip-48x79a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:51 INFO - Running setup.py (path:/tmp/pip-YTuAy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:51 INFO - Running setup.py (path:/tmp/pip-6VObZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:51 INFO - Running setup.py (path:/tmp/pip-_MOtyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:51 INFO - Running setup.py (path:/tmp/pip-mrKQZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:51 INFO - Running setup.py (path:/tmp/pip-nefUh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:51 INFO - Running setup.py (path:/tmp/pip-6u98I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:51 INFO - Running setup.py (path:/tmp/pip-fmZYG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:51 INFO - Running setup.py (path:/tmp/pip-hvxVKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:51 INFO - Running setup.py (path:/tmp/pip-PKBys9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:51 INFO - Running setup.py (path:/tmp/pip-pfNNFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:51 INFO - Running setup.py (path:/tmp/pip-2ynZsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:51 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)) 04:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:51 INFO - Running setup.py (path:/tmp/pip-r2WpW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:52 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)) 04:13:52 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)) 04:13:52 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)) 04:13:52 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)) 04:13:52 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)) 04:13:52 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)) 04:13:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:53 INFO - Downloading blessings-1.6.tar.gz 04:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:53 INFO - Installing collected packages: blessings 04:13:53 INFO - Running setup.py install for blessings 04:13:54 INFO - Successfully installed blessings 04:13:54 INFO - Cleaning up... 04:13:54 INFO - Return code: 0 04:13:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:54 INFO - Reading from file tmpfile_stdout 04:13:54 INFO - Current package versions: 04:13:54 INFO - argparse == 1.2.1 04:13:54 INFO - blessings == 1.6 04:13:54 INFO - blobuploader == 1.2.4 04:13:54 INFO - docopt == 0.6.1 04:13:54 INFO - functools32 == 3.2.3-2 04:13:54 INFO - jsonschema == 2.5.1 04:13:54 INFO - manifestparser == 1.1 04:13:54 INFO - mozInstall == 1.12 04:13:54 INFO - mozcrash == 0.17 04:13:54 INFO - mozdebug == 0.1 04:13:54 INFO - mozdevice == 0.48 04:13:54 INFO - mozfile == 1.2 04:13:54 INFO - mozhttpd == 0.7 04:13:54 INFO - mozinfo == 0.9 04:13:54 INFO - mozleak == 0.1 04:13:54 INFO - mozlog == 3.2 04:13:54 INFO - moznetwork == 0.27 04:13:54 INFO - mozprocess == 0.22 04:13:54 INFO - mozprofile == 0.28 04:13:54 INFO - mozrunner == 6.11 04:13:54 INFO - mozscreenshot == 0.1 04:13:54 INFO - mozsystemmonitor == 0.3 04:13:54 INFO - moztest == 0.7 04:13:54 INFO - mozversion == 1.4 04:13:54 INFO - psutil == 3.1.1 04:13:54 INFO - requests == 1.2.3 04:13:54 INFO - wsgiref == 0.1.2 04:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 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 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:54 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 04:13:54 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 04:13:54 INFO - Using env: {'DISPLAY': ':0', 04:13:54 INFO - 'HOME': '/home/cltbld', 04:13:54 INFO - 'LANG': 'en_US.UTF-8', 04:13:54 INFO - 'LANGUAGE': 'en_US:en', 04:13:54 INFO - 'LOGNAME': 'cltbld', 04:13:54 INFO - 'MAIL': '/var/mail/cltbld', 04:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:54 INFO - 'MOZ_NO_REMOTE': '1', 04:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:54 INFO - 'NO_EM_RESTART': '1', 04:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:54 INFO - 'PWD': '/builds/slave/test', 04:13:54 INFO - 'SHELL': '/bin/bash', 04:13:54 INFO - 'SHLVL': '1', 04:13:54 INFO - 'TERM': 'linux', 04:13:54 INFO - 'TMOUT': '86400', 04:13:54 INFO - 'USER': 'cltbld', 04:13:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:54 INFO - '_': '/tools/buildbot/bin/python'} 04:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 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)) 04:13:54 INFO - Cleaning up... 04:13:54 INFO - Return code: 0 04:13:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', '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 04:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:13:54 INFO - Using env: {'DISPLAY': ':0', 04:13:54 INFO - 'HOME': '/home/cltbld', 04:13:54 INFO - 'LANG': 'en_US.UTF-8', 04:13:54 INFO - 'LANGUAGE': 'en_US:en', 04:13:54 INFO - 'LOGNAME': 'cltbld', 04:13:54 INFO - 'MAIL': '/var/mail/cltbld', 04:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:54 INFO - 'MOZ_NO_REMOTE': '1', 04:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:54 INFO - 'NO_EM_RESTART': '1', 04:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:54 INFO - 'PWD': '/builds/slave/test', 04:13:54 INFO - 'SHELL': '/bin/bash', 04:13:54 INFO - 'SHLVL': '1', 04:13:54 INFO - 'TERM': 'linux', 04:13:54 INFO - 'TMOUT': '86400', 04:13:54 INFO - 'USER': 'cltbld', 04:13:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:54 INFO - '_': '/tools/buildbot/bin/python'} 04:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:54 INFO - Cleaning up... 04:13:54 INFO - Return code: 0 04:13:54 INFO - Running post-action listener: _resource_record_post_action 04:13:54 INFO - Running post-action listener: _start_resource_monitoring 04:13:54 INFO - Starting resource monitoring. 04:13:54 INFO - ##### 04:13:54 INFO - ##### Finished create-virtualenv step (success) 04:13:54 INFO - ##### 04:13:54 INFO - ##### 04:13:54 INFO - ##### Running install step. 04:13:54 INFO - ##### 04:13:54 INFO - Running pre-action listener: _resource_record_pre_action 04:13:54 INFO - Running main action method: install 04:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:55 INFO - Reading from file tmpfile_stdout 04:13:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:55 INFO - Reading from file tmpfile_stdout 04:13:55 INFO - Output received: 04:13:55 INFO - Usage: mozinstall [options] installer 04:13:55 INFO - Options: 04:13:55 INFO - -h, --help show this help message and exit 04:13:55 INFO - -d DEST, --destination=DEST 04:13:55 INFO - Directory to install application into. [default: 04:13:55 INFO - "/builds/slave/test"] 04:13:55 INFO - --app=APP Application being installed. [default: firefox] 04:13:55 INFO - mkdir: /builds/slave/test/build/application 04:13:55 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'] 04:13:55 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 04:14:12 INFO - Reading from file tmpfile_stdout 04:14:12 INFO - Output received: 04:14:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:12 INFO - Running post-action listener: _resource_record_post_action 04:14:12 INFO - ##### 04:14:12 INFO - ##### Finished install step (success) 04:14:12 INFO - ##### 04:14:12 INFO - ##### 04:14:12 INFO - ##### Running run-tests step. 04:14:12 INFO - ##### 04:14:12 INFO - Running pre-action listener: _resource_record_pre_action 04:14:12 INFO - Running main action method: run_tests 04:14:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:12 INFO - Python 2.7.3 04:14:12 INFO - Return code: 0 04:14:12 INFO - grabbing minidump binary from tooltool 04:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:12 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 0x25243b0>, '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 0x25252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2525740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:12 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 04:14:12 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 04:14:12 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 04:14:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:12 INFO - Return code: 0 04:14:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 04:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 04:14:12 INFO - Using env: {'DISPLAY': ':0', 04:14:12 INFO - 'HOME': '/home/cltbld', 04:14:12 INFO - 'LANG': 'en_US.UTF-8', 04:14:12 INFO - 'LANGUAGE': 'en_US:en', 04:14:12 INFO - 'LOGNAME': 'cltbld', 04:14:12 INFO - 'MAIL': '/var/mail/cltbld', 04:14:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:12 INFO - 'MOZ_NO_REMOTE': '1', 04:14:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:12 INFO - 'NO_EM_RESTART': '1', 04:14:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:12 INFO - 'PWD': '/builds/slave/test', 04:14:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:12 INFO - 'SHELL': '/bin/bash', 04:14:12 INFO - 'SHLVL': '1', 04:14:12 INFO - 'TERM': 'linux', 04:14:12 INFO - 'TMOUT': '86400', 04:14:12 INFO - 'USER': 'cltbld', 04:14:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626', 04:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:12 INFO - '_': '/tools/buildbot/bin/python'} 04:14:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 04:14:12 INFO - mozversion application_buildid: 20160704013020 04:14:12 INFO - mozversion application_changeset: 55eb13faa8e016818d8fd96e6e30e3fb89dd0af7 04:14:12 INFO - mozversion application_display_name: Nightly 04:14:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:12 INFO - mozversion application_name: Firefox 04:14:12 INFO - mozversion application_remotingname: firefox 04:14:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:14:12 INFO - mozversion application_vendor: Mozilla 04:14:12 INFO - mozversion application_version: 50.0a1 04:14:12 INFO - mozversion platform_buildid: 20160704013020 04:14:12 INFO - mozversion platform_changeset: 55eb13faa8e016818d8fd96e6e30e3fb89dd0af7 04:14:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:14:12 INFO - mozversion platform_version: 50.0a1 04:14:12 INFO - using testdate: 1467630852 04:14:12 INFO - actual date: 1467630852 04:14:12 INFO - starting webserver on 'localhost:38718' 04:14:12 INFO - SUITE-START | Running 2 tests 04:14:12 INFO - TEST-START | dromaeo_css 04:14:12 INFO - operating with platform_type : linux_ 04:14:12 INFO - Initialising browser for dromaeo_css test... 04:14:12 INFO - TEST-INFO | started process 5981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Lxd1w/profile http://localhost:38718/getInfo.html) 04:14:16 INFO - PROCESS | 5981 | __metrics Screen width/height:1600/1200 04:14:16 INFO - PROCESS | 5981 | colorDepth:24 04:14:16 INFO - PROCESS | 5981 | Browser inner width/height: 1024/697 04:14:16 INFO - PROCESS | 5981 | __metrics 04:14:17 INFO - PROCESS | 5981 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:18 INFO - TEST-INFO | 5981: exit 0 04:14:18 INFO - Browser initialized. 04:14:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:18 INFO - TEST-INFO | started process 6065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Lxd1w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:30 INFO - PROCESS | 6065 | RSS: Main: 157564928 04:14:30 INFO - PROCESS | 6065 | 04:15:21 INFO - PROCESS | 6065 | 1467630921773 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] 04:17:29 INFO - PROCESS | 6065 | Cycle 1(1): loaded http://localhost:38718/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38718/tests/dromaeo/cssquery-ext.html) 04:17:30 INFO - PROCESS | 6065 | RSS: Main: 256167936 04:17:30 INFO - PROCESS | 6065 | 04:20:33 INFO - PROCESS | 6065 | Cycle 1(1): loaded http://localhost:38718/tests/dromaeo/cssquery-ext.html (next: http://localhost:38718/tests/dromaeo/cssquery-jquery.html) 04:20:33 INFO - PROCESS | 6065 | RSS: Main: 237522944 04:20:33 INFO - PROCESS | 6065 | 04:23:35 INFO - PROCESS | 6065 | Cycle 1(1): loaded http://localhost:38718/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38718/tests/dromaeo/cssquery-mootools.html) 04:23:36 INFO - PROCESS | 6065 | RSS: Main: 241917952 04:23:36 INFO - PROCESS | 6065 | 04:26:38 INFO - PROCESS | 6065 | Cycle 1(1): loaded http://localhost:38718/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38718/tests/dromaeo/cssquery-prototype.html) 04:26:39 INFO - PROCESS | 6065 | RSS: Main: 239919104 04:26:39 INFO - PROCESS | 6065 | 04:29:41 INFO - PROCESS | 6065 | Cycle 1(1): loaded http://localhost:38718/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38718/tests/dromaeo/cssquery-yui.html) 04:29:42 INFO - PROCESS | 6065 | RSS: Main: 224055296 04:29:42 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | Cycle 1(1): loaded http://localhost:38718/tests/dromaeo/cssquery-yui.html (next: http://localhost:38718/tests/dromaeo/cssquery-dojo.html) 04:32:45 INFO - PROCESS | 6065 | RSS: Main: 266567680 04:32:45 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | __start_tp_report 04:32:45 INFO - PROCESS | 6065 | _x_x_mozilla_page_load 04:32:45 INFO - PROCESS | 6065 | _x_x_mozilla_page_load_details 04:32:45 INFO - PROCESS | 6065 | |i|pagename|runs| 04:32:45 INFO - PROCESS | 6065 | |0;dojo.html;3093.0720783764873;3097.2876238465137;3135.576697145885;3137.2784259620303;3154.9211269718253;5130.6152038597165;5195.506426889449;5217.739113044347;5281.419043905172;5317.840464786058;5196.506331898473;5211.817586384477;5260.342457192851;5277.6305658603915;5300.151975683882;4782.569568738812;4827.63792715546;4870.001649661811;4874.512548745132;5013.799448022093;4924.926126108094;4935.161022626162;4946;4998.2752500887345;5011.799528018875;4712.6229901607785;4726.787294571753;4742.264948932921;4832.371791667061;4838.903221935541;4804.8318308859025;4825.179719447702;4905.828296009622;4919.901601967977;4965.950340496621;4713.95286047142;4858.587020103296;4885.120678277908;4903.411590609114;4937.629677774145;5146.716930568818;5222.242774797671;5224.9738751306;5291.126964050927;5300.09898317287;5576.358718747315;5640.943590564083;5659.094544872842;5666.9716651416475;5673.063944449161;5520.751566179531;5567.137093750475;5750.511206547449;5827.737751801179;5836.503897168745;5229.869253268661;5299.231611416361;5322.946770532284;5323.441038690959;5331.120365139747;5840.474357307863;5858.853528661817;5861.062230043172;5864.824055278348;5865.589408741433;5243.239730239094;5425.674459532441;5466.644668096561;5604.551635869121;5609.887802243932;5630.971845140748;5634.3802181759975;5638.746256418389;5640.971795140998;5645.5483561314995;5574.58190635704;5581.107022876401;5581.274434323512;5583.944160558423;5625.043742563774;5380.892382152413;5585.553155747531;5591.10542313228;5640.717964101778;5654.4062873398525;4335.913281734411;4355.455568053993;4359.237133501624;4364.148990946798;4393.890152746143;3842.1355195080882;3860.7876566789096;3877.86427475037;3881.84472621092;3900.941485877657;5180.093483640348;5184.015037142931;5226.059309324358;5245.606579506552;5245.659032162897;5568.415316391721;5583.190437386556;5592.524635406036;5596.048671725735;5632.802851900164;5201.245819356248;5261.053010458078;5261.105612045962;5265.4997775211295;5300.602454815904;4658.906821863544;4659.743714095757;4693.178693728652;4698.7415692137265;4714.976425117852;5800.56495762811;5806.88386232273;5810.1865738796605;5812.651240925558;5814.302283725895;5508.173773933942;5578.525825304894;5583.469570390806;5593.244911936999;5647.463490968352;5875.618084824473;5929.080992446177;5934.821955341174;5949.3753155918;5968.76124954997;5619.157126431068;5634.6337488063145;5641.097424412074;5641.661500309994;5646.943530564642;5459;5517.172424136412;5719.428057194247;5732.799352022659;5745.798897038583;5453.563714902719;5487.368952570506;5488.313960754906;5491.807786727445;5551.861203469945;5423.29497165366;5430.049741295178;5467.753951072132;5470.589705772003;5471.151971444432;5315.0964336063735;5380.704061276668;5411.567074634098;5420.83737487876;5447.754851031634;5560.499555040065;5577.051901176891;5625.184348269396;5626.409227031103;5639.182318563868;5399.136138217867;5435.402105768283;5446.891062178655;5448.809291674773;5450.700211488406 04:32:45 INFO - PROCESS | 6065 | |1;ext.html;594.4471641373524;611.9694015299235;628.7453581299575;632.5888172687755;634.4987459906674;31455.68544314556;42392.36411453831;43468.3479747804;43600.56399436005;43606.563934360645;45583.31625025627;45817.54182458174;45862.31206531896;46246.306305405444;46276.53723462764;8026.197380261986;8984.236339911098;9127;9137.497437640926;9137.63449462024;10562.894371056307;10840.186985976045;10855.620053298137;11180.552777888875;11208.327500350006;10950.233483656148;11034.448277586129;11051.834222486668;11053.889461105407;11057;10680.732981675481;10811.513481893333;10812.080973117294;10844.240903136784;10850;10843.295185812896;10857.45712714369;10893;10909.672709818718;10916.235863489559;42007.579924200676;42221.78889105566;42354.78822605898;42363.57636423658;42365.788171059256;3481.8085005324697;3603.3694103531775;3686.7972261525606;3778.282126395976;4058.553559108496;33325.88831479517;33366.33267334664;33380.833095834605;33714.49428258578;34506.82746586276;4509.346144808985;4527.569880861313;4646.83736069236;4664.906701865978;4692.389989301403;339943;342169;342880;343302;344089;59364;59399.70300148472;59648;59807.700961495786;59823.40176598266;35240.82379588085;36065.81967090148;36141.277174456365;37614.811925940194;37616;16797.160141992852;16935.91532042332;16976.40582579604;16992.91503542499;17002.234899429557;11829;12802.551910683082;12988.675283117998;13114.278714670594;13201.40593673287;19089.90455047716;19243.134058967382;19264.229430822612;19283.807161928202;19465.708014379794;6799.150106236721;7033.507654464139;7053;7068.575885446787;7185.461090418239;832.6586099699215;894.9821003579892;940.0787228516092;976.5605477535138;994.7861209839774;32131;32883.83558082242;33161.66838331634;33389.66610333914;33496.83251583727;1103.7351035751522;1115.8382034604938;1184.514349116858;1214.4595654933646;1262.1543565810746;17423.47729568115;17564.560885977953;17596.472105836845;17605.295788168587;17617;570327;572122;572597;575856;577554;58264.70867645634;58683.413165868646;58751;58760;58782.82434351289;1283.5058502476613;1335.4057444437133;1349.2376807103956;1355.8915286777035;1363.4341748174595;31463.370732585678;32079.839600801846;32466.513002305455;32506.349873001935;32896.342073158885;50125.49874501208;50226.497735023644;50540.24189637085;50566.74716626394;50632.493675062775;475360;477758;478598;478865;479416;24547.754522454547;24915.750842492067;25441.618375724007;25510.87244563765;28159.296017599725;47794.5220547804;48120.51879481161;48255.517444825105;48995;49201.753991229816;39854.60145398509;40505.93675790526;40742;41031;42020.1595968085;40777;41559.37660935028;41571;41630;42355.364669529365;40166.1966760669;40551.1889762209;40668.79665601653;41129.79435102805;41489;35437.645623544464;36274;36898;36982.63017369792;36984.44523332206;27866.721332786412;28057.859710701316;28153;28198.43603127967;28356.43287134287 04:32:45 INFO - PROCESS | 6065 | |2;jquery.html;390.81241004317945;392.3428257668406;393.641785974763;398.5735263268303;417.74935038976616;14645.6338591535;18168.092350303225;19130.521736956565;20408.59182816343;20415.693764593525;14882;17294.654106917853;18231.817681823177;19203.615927681472;19514;5599.692016939057;5711.314642242936;5730.7421166047625;5735.6271842330325;5764.279465066867;4160.06398560323;5617.691026993513;5686.857828554278;6112.69436528174;6394.872102557946;6388.616682999012;6409.551331406803;6425.839354016163;6447.451966582846;6454.838629034288;6218.533609979247;6381.744730210786;6410.487161027107;6417.518686098561;6419.293877673452;5454.945450545483;5647.519960803336;5649.717514124277;5664.348599911022;5666.716664166775;22848.428789280235;22960.540789184124;23026.769732302797;23100.306990790305;23552.293431197093;2301.1255722825385;2444.9144279950115;2603.8307510011787;2779.0050586033294;2798.0486634544354;7216.386607138399;7278.272172782732;11425.571803524559;14767.556973290819;14781.630459238497;1939.9612007759906;1940.3790786948182;1986.5232344237425;1994.6409646263667;2010.7084472751515;51874;54128.72935635297;81116.59441702753;82883.58558207231;83768.58115709382;10338.328008679562;10379.84430233547;10608.363498190134;10840.403777792297;11139.275947063416;14781.48264810748;14971.401143954337;14981;14981.850181498046;15015.849841501664;7968;8222.301104406193;8308.459950103224;8416.621252043673;8420;7318.3047610476915;8243.422960392714;8291.917080829235;8478.703245386381;8487.660493580188;6254.937450625526;6444.613323200623;6545.607263564201;6599.53803233769;6602.966985165043;1851.1114664960626;1866.496046067554;1894.3843250943498;1926.1428664244277;1968.045497933501;973.2116985241977;994.8060128274917;1037.5940600486383;1097.3744965369663;1117.2681893359863;19781;19862.801371986094;19881;19934.601307974048;19937;1001.4041645221082;1003.4380746781826;1039.750459889621;1049.8425236214475;1087.0162502934857;10978;11402.087832973508;11481.540738370371;11502.712432189095;11508.19442639024;447335;462187;477046;477993;478251;79916;80212.59893700611;81013.59493202614;81323.18676813156;82344.58827705822;988.5403287471361;998.9300748947504;1006.9949650251701;1030.2015937648382;1040.1262939131166;17424.390146344816;17797.911010444866;17935.103244837966;17964.10179490994;18264.726029109308;44590.3311450322;44978.3253251195;45093.54906451025;45415;45491.54508454873;61504.384956149865;61579;62409;62484;63783;7338.889916651147;7378.557286562824;7495.512791668524;8328.417010809186;8509.87235191485;9240.306976976619;12867.871321286668;13208.537701180412;13278.53525126616;13537.1200871943;11359.943200284277;11733.706657333634;11735.354555499529;11740.979613026951;11818.172727909308;11764.470598822902;11777.293362398283;11792.351420671945;11924.105692073303;12026.436563246722;11807.527698891949;12003.939980300043;12011.399430028638;12054.517819287481;12309.138360314691;7487.288707572772;7550.622468876644;7599.734009309647;7749.225077492206;7902.802429939297;10022.649207277711;11988.580399685969;12327.876721232673;12400;12436.316002619942 04:32:45 INFO - PROCESS | 6065 | |3;mootools.html;1320.9669758256036;1435.748743969805;1458.132411215327;1578.0610536730642;1742.5643589102733;8265.380096492765;8618.181272779084;8630.395872288942;8645.74062778116;8888.111188881125;8047.718329858456;8150.796230094251;8565.057843637194;8569.143085691428;8575.271101956341;1978.6834106542956;2047.2322878920404;2276.4877902471976;2296.1274715608088;2343.086196383403;2331.6852224949585;2355.128602417108;2355.2345487716475;2358.6697862299293;2359.1389142962867;2296.827737919663;2307.065638416444;2338.7895089441945;2341.0869760793303;2342.121704360865;1938.9709154362695;2135.8398120140896;2144.8391370647187;2204.382772823612;2211.2702808073295;2234;2235.2623634200836;2244.831637627168;2248.640217565198;2248.9437764055865;8764.079771624016;8878.11218878107;8881.111888811132;8894.555272236426;8896.911030889672;5056.696598204119;5186.392218412304;5224.686518808883;5224.738763061831;5227.8170264040955;3254.4304746669236;3260.836958152083;3292.242784159657;3323.1692076980753;3359.7312215022985;1101.1576144249655;1117.2626066795876;1121.1199208621192;1123.0790751583704;1138.8576427946507;11730.35483048432;11902.523899044028;11938.28370297785;11981.400929953468;11999.52001919922;4267.722598031118;4414.977925110354;4473.150101480708;4555.544445555418;4577.5193604671695;10028.498575071364;10030.047145521165;10032.398056116657;10040.598376065022;10044.045815647502;5089.720065396439;5091.0581542414775;5091.694498330112;5094.2103973884105;5094.261332106824;4281.97859010703;4714.245720684674;4853.830115945925;4856.757162141878;4884.633652476078;3920.784356860343;3995.180987897474;4010.7393019454225;4125.566815484391;4175.144095460423;1153.377176324792;1236.3756303066893;1268;1280.1103233252986;1289.348878816192;840.0843081041572;887.1837909123622;930.15356026016;945.7493764152505;966.840471322238;6068.939310606926;6134.8159555213415;6299.149614802035;6299.6535190564955;6380.0748891410485;969.3311614985637;993.0218734546465;994.8557459168525;1003.5484032185545;1007.219404961161;4207.326827707552;4265.7440553566885;4314.892127696833;4356.564343565681;4367.061081867414;10898.782024359469;11222;11274.098072154207;11281.71795705114;11307.830382544269;10444.634437794793;10776;10809.56761729522;11142.721431964266;11189.384583847805;8205.384596155312;8295.087540370554;8326.916730832736;8338.541380224025;8341.708040218564;6148.200733904742;6351.079093531504;6375.298717141203;6380.585261957958;6409.359064093554;10060.446675432922;10269.743256418351;10338.844917326396;10342.5345859435;10384.32501887375;10366.481675916024;10439.791204176026;10505.78988420212;10521.210909181995;10543.051125398752;7908.920910791048;8022.679092836454;8026.598670066356;8028.518288902685;8031.59842007909;8335.541545215072;8725.869111963453;8731.34514911397;8969.416987895765;8983.685571004984;7809.726659567115;7813.609319534115;7904.604769761374;7938.841223175388;8158.5920703963375;7725.729599463992;7751.806204844924;7803.375729941705;7886.802829929068;7901.762947111596;7357.5953322567775;7376.041114655275;7411.1477180124975;7413.777586672409;7433.92566074354;5009.574186194214;5048.949510504848;5217.373915130209;5240.502152295526;5318.973405133104;5411.188321751769;5426.593005524523;5473.890522189614;5504.669719816664;5649.6327738696855 04:32:45 INFO - PROCESS | 6065 | |4;prototype.html;308.34476736934;324.8484123781195;328.4252558023459;333.28344060270416;335.43311803052836;5235.476452354767;5251.291075704778;5256.973715131419;5306.310179676641;5323.760430780614;5006.4492905780335;5045.243213517974;5060.84817455476;5126.641135120543;5243.239730239113;3958.2479328927557;4033.2135233629456;4124.731892426983;4141.130362623852;4180.456540649727;4081.265372233012;4140.648044916185;4146.6268035876765;4163.479565054368;4168.62482376586;3953.881383558498;4113.745307681156;4125.8968525786795;4145.709800313979;4151.252774500589;4062.923325318793;4067.5560176137637;4080.816563196699;4121.216968775923;4134.317837556815;3601.1717305019993;3605.9819700901326;3607.8917632471066;3609.3864043112735;3613.223157021253;4858.951410485885;5123.462036486189;5130.769115389817;5134.614903882224;5140.203268493389;4671.11248862715;4694.600958918496;4719.598834099105;4724.220503616899;4728.243481043051;5422;5432.809851655173;5448.56411487084;5459.563234941195;5549.6115271930985;3852.6339997700175;3945.2109578084496;3950.4271880577157;3951.8221680024467;3981.7610943343493;5635.380108188096;5643.714295710203;5644.068728659766;5664.348599911022;5687.744051517691;4033.153037862082;4033.2135233629747;4037.5356833963883;4038.8990275243355;4040.515138183378;4112.259793237186;4114.855980040684;4118.320477121301;4138.5654506276405;4138.896527586834;4525.705829121162;4630.814767409266;4634.745089020136;4637.930431043537;4648.6745927785405;5404.243405923174;5413.566914646819;5418.241446197536;5432.837014889559;5525.309336332958;1331.3276795218353;1363.3387806913638;1387.1607677355257;1395.827504895872;1402.2708191740237;952.5618215620754;954.4559601027487;971.50453268832;975.9414435133773;977.7604486900613;5131;5152.789094562775;5175.767090480862;5191.558717509054;5193.636445448858;5452.291202143696;5500.80747173855;5514.6691198527415;5516.668999860021;5517.834464966058;4913.5286888930905;5168.948310516922;5169.870753231199;5172.456892026358;5203.349581302337;2610.3474131467133;2629.6318515407856;2636.419987602724;2639.4792972711016;2651.8939242430088;5085.95737873735;5093.719845408538;5094.872628184251;5105.387353517527;5117.923231151536;4910.852674419773;5047.798088076509;5054.69671819692;5088.211327244283;5156.561692256125;5034.338668239399;5081.526357356325;5122.769475373617;5138.460461651547;5145.331106956071;4925.433575138905;4941.43173535048;4946.307516947558;4957.776900039579;5007.649464537593;4878.341423907727;4914.108068393765;5211.348581427322;5549.250851135045;5554.611177217717;5831.912521312269;5850.882982340415;5852.215074402178;5863.237779088691;5875.618084824473;3956.643902048829;3995.08113133975;4009.4587230723478;4016.116454380032;4019.4975628046495;5325.813596524103;5397;5571.415001424954;5608.6073974823;5692.288463942007;5313;5432.837014889559;5461.918071228855;5468.644538105011;5527.2538207341495;5486.506214440719;5516.310461192351;5523.486813499928;5530.142827861688;5548.778048878;5200.921986170135;5415.2147938547905;5423.511883930465;5452.781888724407;5452.836414907559;5507.449255074621;5517.503424691797;5521.779128834963;5522.641028333145;5542.584306177134;5431.34823821144;5458.8908221834545;5468.425815289337;5485.369182544058;5490.5882058844945 04:32:45 INFO - PROCESS | 6065 | |5;yui.html;714.3677845107079;725.3363172696982;753.1489416958839;775.4300589067038;815.8735396013618;14380.352884120213;14856.628584285398;15229.999999999985;15261.084334939911;16633.91683041583;13852.445902163901;13857.722845543083;13865;13974.09168404053;14039.36822842972;647.9384458476461;767.7466436076081;784.1374488063142;801.3428988229625;802.6909639788694;808.0787901791962;818.1859050245015;818.55388813097;818.8362327534517;818.9017317921857;851.2891735400948;852.5779739029189;852.9189726975927;853.4623187391966;853.6158728572136;669.5279827721469;807.2532907061004;836.4730219961385;846.699421705295;846.9618867150962;601.9006863867456;608.9330173680892;611.587178654411;611.703323887914;611.8776244751068;13929.512467063603;13953.3720982555;13954.441822327095;13956.302184890816;14035.228062456561;13752.793708094387;14084.295785210801;14255.358508867022;14291.499797507142;14569.635759106;12708;12821.551245706449;13063.216207027608;13108.082434229607;13110.934445327712;4442.267025940716;4464.732116073046;4506.369108324837;4517.299818528133;4699.154152252628;76243;77006;79760.60119699422;79943.60028199939;80541;10801.945990269998;10910.72723181911;10926.562937482411;11011.83482247767;11297.378644174485;19176.232950682097;19702.901485492766;19764.505887352643;20589.38231853047;20628.27801026957;8343.916560834436;8351.749447516584;8379.329653627818;8398.370122240734;8538.87191692125;4521.977390113028;4572.7713614319155;4690;4700.056903832512;4715.858524244278;2993.925151871221;3097.241175911916;3098;3132.859021344045;3167.255694911694;504.2738456622452;603.7343568829701;606.6996836565928;616.5006344860677;617.139090968106;574.319431473705;663.986720265592;669.3172963577124;708.1855865754321;743.9181690014094;9306.72079837606;9654.519168453091;9953.502324883726;9973.700788976343;10149.695509134737;572.782342709776;652.4617190817595;680.1124532485154;720.8270015196315;731.2541207967843;4805.711657300573;4890.1931181355385;4895.094407534618;4926.4088309403105;4957.157283261854;124274;125227.3738631301;126950.36524817502;126996.36501817616;131123;106720;108511.45744271229;109161;109714;116382;95221.5238923801;95222;95678.52160739152;98223.50888245513;98354.01645983591;8887.777805554913;9242.623827587115;9322.440653560809;9375;9459.581062840629;42287.577124228366;53369;53591.73204133954;55017.72491137519;55947.44052559585;75712.86430703654;84033;85133.57433212794;85177.57411212905;85326.57336713276;11258.605948791754;11427.142964277878;11471.311721296748;11601.566002211677;11900.702482438008;12559.246445213317;12705.301208433624;12972.935135324264;14656.633584160481;15068.547943561272;14382.137071775309;14539.547966642605;14650.413983440969;14716.632084197981;15232.238388080774;12609.43257553394;12746.68133296675;12763.553275635308;13601.387937542637;13651.931740341632;14175.291235438393;14338.713225735219;14652.19412932299;15107;15139.470118545798;10639.521221544894;10991.285566438157;11213.775724485628;11420.143489238175;11579.826302605636;11352.489137988645;11508.53965841357;11526.193166478266;11570.59502917394;11742.471588778697 04:32:45 INFO - PROCESS | 6065 | __end_tp_report 04:32:45 INFO - PROCESS | 6065 | __start_cc_report 04:32:45 INFO - PROCESS | 6065 | _x_x_mozilla_cycle_collect,876 04:32:45 INFO - PROCESS | 6065 | __end_cc_report 04:32:45 INFO - PROCESS | 6065 | __startTimestamp1467631965444__endTimestamp 04:32:45 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | ------- Summary: start ------- 04:32:45 INFO - PROCESS | 6065 | Number of tests: 6 04:32:45 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | [#0] dojo.html Cycles:165 Average:5240.24 Median:5423.29 stddev:581.80 (10.7%) stddev-sans-first:558.67 04:32:45 INFO - PROCESS | 6065 | Values: 3093.1 3097.3 3135.6 3137.3 3154.9 5130.6 5195.5 5217.7 5281.4 5317.8 5196.5 5211.8 5260.3 5277.6 5300.2 4782.6 4827.6 4870.0 4874.5 5013.8 4924.9 4935.2 4946.0 4998.3 5011.8 4712.6 4726.8 4742.3 4832.4 4838.9 4804.8 4825.2 4905.8 4919.9 4966.0 4714.0 4858.6 4885.1 4903.4 4937.6 5146.7 5222.2 5225.0 5291.1 5300.1 5576.4 5640.9 5659.1 5667.0 5673.1 5520.8 5567.1 5750.5 5827.7 5836.5 5229.9 5299.2 5322.9 5323.4 5331.1 5840.5 5858.9 5861.1 5864.8 5865.6 5243.2 5425.7 5466.6 5604.6 5609.9 5631.0 5634.4 5638.7 5641.0 5645.5 5574.6 5581.1 5581.3 5583.9 5625.0 5380.9 5585.6 5591.1 5640.7 5654.4 4335.9 4355.5 4359.2 4364.1 4393.9 3842.1 3860.8 3877.9 3881.8 3900.9 5180.1 5184.0 5226.1 5245.6 5245.7 5568.4 5583.2 5592.5 5596.0 5632.8 5201.2 5261.1 5261.1 5265.5 5300.6 4658.9 4659.7 4693.2 4698.7 4715.0 5800.6 5806.9 5810.2 5812.7 5814.3 5508.2 5578.5 5583.5 5593.2 5647.5 5875.6 5929.1 5934.8 5949.4 5968.8 5619.2 5634.6 5641.1 5641.7 5646.9 5459.0 5517.2 5719.4 5732.8 5745.8 5453.6 5487.4 5488.3 5491.8 5551.9 5423.3 5430.0 5467.8 5470.6 5471.2 5315.1 5380.7 5411.6 5420.8 5447.8 5560.5 5577.1 5625.2 5626.4 5639.2 5399.1 5435.4 5446.9 5448.8 5450.7 04:32:45 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | [#1] ext.html Cycles:180 Average:61888.92 Median:36983.54 stddev:126040.03 (340.8%) stddev-sans-first:126309.59 04:32:45 INFO - PROCESS | 6065 | Values: 594.4 612.0 628.7 632.6 634.5 31455.7 42392.4 43468.3 43600.6 43606.6 45583.3 45817.5 45862.3 46246.3 46276.5 8026.2 8984.2 9127.0 9137.5 9137.6 10562.9 10840.2 10855.6 11180.6 11208.3 10950.2 11034.4 11051.8 11053.9 11057.0 10680.7 10811.5 10812.1 10844.2 10850.0 10843.3 10857.5 10893.0 10909.7 10916.2 42007.6 42221.8 42354.8 42363.6 42365.8 3481.8 3603.4 3686.8 3778.3 4058.6 33325.9 33366.3 33380.8 33714.5 34506.8 4509.3 4527.6 4646.8 4664.9 4692.4 339943.0 342169.0 342880.0 343302.0 344089.0 59364.0 59399.7 59648.0 59807.7 59823.4 35240.8 36065.8 36141.3 37614.8 37616.0 16797.2 16935.9 16976.4 16992.9 17002.2 11829.0 12802.6 12988.7 13114.3 13201.4 19089.9 19243.1 19264.2 19283.8 19465.7 6799.2 7033.5 7053.0 7068.6 7185.5 832.7 895.0 940.1 976.6 994.8 32131.0 32883.8 33161.7 33389.7 33496.8 1103.7 1115.8 1184.5 1214.5 1262.2 17423.5 17564.6 17596.5 17605.3 17617.0 570327.0 572122.0 572597.0 575856.0 577554.0 58264.7 58683.4 58751.0 58760.0 58782.8 1283.5 1335.4 1349.2 1355.9 1363.4 31463.4 32079.8 32466.5 32506.3 32896.3 50125.5 50226.5 50540.2 50566.7 50632.5 475360.0 477758.0 478598.0 478865.0 479416.0 24547.8 24915.8 25441.6 25510.9 28159.3 47794.5 48120.5 48255.5 48995.0 49201.8 39854.6 40505.9 40742.0 41031.0 42020.2 40777.0 41559.4 41571.0 41630.0 42355.4 40166.2 40551.2 40668.8 41129.8 41489.0 35437.6 36274.0 36898.0 36982.6 36984.4 27866.7 28057.9 28153.0 28198.4 28356.4 04:32:45 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | [#2] jquery.html Cycles:180 Average:28081.74 Median:2691.42 stddev:77087.17 (2864.2%) stddev-sans-first:77275.38 04:32:45 INFO - PROCESS | 6065 | Values: 390.8 392.3 393.6 398.6 417.7 14645.6 18168.1 19130.5 20408.6 20415.7 14882.0 17294.7 18231.8 19203.6 19514.0 5599.7 5711.3 5730.7 5735.6 5764.3 4160.1 5617.7 5686.9 6112.7 6394.9 6388.6 6409.6 6425.8 6447.5 6454.8 6218.5 6381.7 6410.5 6417.5 6419.3 5454.9 5647.5 5649.7 5664.3 5666.7 22848.4 22960.5 23026.8 23100.3 23552.3 2301.1 2444.9 2603.8 2779.0 2798.0 7216.4 7278.3 11425.6 14767.6 14781.6 1940.0 1940.4 1986.5 1994.6 2010.7 51874.0 54128.7 81116.6 82883.6 83768.6 10338.3 10379.8 10608.4 10840.4 11139.3 14781.5 14971.4 14981.0 14981.9 15015.8 7968.0 8222.3 8308.5 8416.6 8420.0 7318.3 8243.4 8291.9 8478.7 8487.7 6254.9 6444.6 6545.6 6599.5 6603.0 1851.1 1866.5 1894.4 1926.1 1968.0 973.2 994.8 1037.6 1097.4 1117.3 19781.0 19862.8 19881.0 19934.6 19937.0 1001.4 1003.4 1039.8 1049.8 1087.0 10978.0 11402.1 11481.5 11502.7 11508.2 447335.0 462187.0 477046.0 477993.0 478251.0 79916.0 80212.6 81013.6 81323.2 82344.6 988.5 998.9 1007.0 1030.2 1040.1 17424.4 17797.9 17935.1 17964.1 18264.7 44590.3 44978.3 45093.5 45415.0 45491.5 61504.4 61579.0 62409.0 62484.0 63783.0 7338.9 7378.6 7495.5 8328.4 8509.9 9240.3 12867.9 13208.5 13278.5 13537.1 11359.9 11733.7 11735.4 11741.0 11818.2 11764.5 11777.3 11792.4 11924.1 12026.4 11807.5 12003.9 12011.4 12054.5 12309.1 7487.3 7550.6 7599.7 7749.2 7902.8 10022.6 11988.6 12327.9 12400.0 12436.3 04:32:45 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | [#3] mootools.html Cycles:180 Average:5837.74 Median:4514.35 stddev:3321.53 (73.6%) stddev-sans-first:3313.50 04:32:45 INFO - PROCESS | 6065 | Values: 1321.0 1435.7 1458.1 1578.1 1742.6 8265.4 8618.2 8630.4 8645.7 8888.1 8047.7 8150.8 8565.1 8569.1 8575.3 1978.7 2047.2 2276.5 2296.1 2343.1 2331.7 2355.1 2355.2 2358.7 2359.1 2296.8 2307.1 2338.8 2341.1 2342.1 1939.0 2135.8 2144.8 2204.4 2211.3 2234.0 2235.3 2244.8 2248.6 2248.9 8764.1 8878.1 8881.1 8894.6 8896.9 5056.7 5186.4 5224.7 5224.7 5227.8 3254.4 3260.8 3292.2 3323.2 3359.7 1101.2 1117.3 1121.1 1123.1 1138.9 11730.4 11902.5 11938.3 11981.4 11999.5 4267.7 4415.0 4473.2 4555.5 4577.5 10028.5 10030.0 10032.4 10040.6 10044.0 5089.7 5091.1 5091.7 5094.2 5094.3 4282.0 4714.2 4853.8 4856.8 4884.6 3920.8 3995.2 4010.7 4125.6 4175.1 1153.4 1236.4 1268.0 1280.1 1289.3 840.1 887.2 930.2 945.7 966.8 6068.9 6134.8 6299.1 6299.7 6380.1 969.3 993.0 994.9 1003.5 1007.2 4207.3 4265.7 4314.9 4356.6 4367.1 10898.8 11222.0 11274.1 11281.7 11307.8 10444.6 10776.0 10809.6 11142.7 11189.4 8205.4 8295.1 8326.9 8338.5 8341.7 6148.2 6351.1 6375.3 6380.6 6409.4 10060.4 10269.7 10338.8 10342.5 10384.3 10366.5 10439.8 10505.8 10521.2 10543.1 7908.9 8022.7 8026.6 8028.5 8031.6 8335.5 8725.9 8731.3 8969.4 8983.7 7809.7 7813.6 7904.6 7938.8 8158.6 7725.7 7751.8 7803.4 7886.8 7901.8 7357.6 7376.0 7411.1 7413.8 7433.9 5009.6 5048.9 5217.4 5240.5 5319.0 5411.2 5426.6 5473.9 5504.7 5649.6 04:32:45 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | [#4] prototype.html Cycles:180 Average:4519.33 Median:5100.13 stddev:1308.84 (25.7%) stddev-sans-first:1273.78 04:32:45 INFO - PROCESS | 6065 | Values: 308.3 324.8 328.4 333.3 335.4 5235.5 5251.3 5257.0 5306.3 5323.8 5006.4 5045.2 5060.8 5126.6 5243.2 3958.2 4033.2 4124.7 4141.1 4180.5 4081.3 4140.6 4146.6 4163.5 4168.6 3953.9 4113.7 4125.9 4145.7 4151.3 4062.9 4067.6 4080.8 4121.2 4134.3 3601.2 3606.0 3607.9 3609.4 3613.2 4859.0 5123.5 5130.8 5134.6 5140.2 4671.1 4694.6 4719.6 4724.2 4728.2 5422.0 5432.8 5448.6 5459.6 5549.6 3852.6 3945.2 3950.4 3951.8 3981.8 5635.4 5643.7 5644.1 5664.3 5687.7 4033.2 4033.2 4037.5 4038.9 4040.5 4112.3 4114.9 4118.3 4138.6 4138.9 4525.7 4630.8 4634.7 4637.9 4648.7 5404.2 5413.6 5418.2 5432.8 5525.3 1331.3 1363.3 1387.2 1395.8 1402.3 952.6 954.5 971.5 975.9 977.8 5131.0 5152.8 5175.8 5191.6 5193.6 5452.3 5500.8 5514.7 5516.7 5517.8 4913.5 5168.9 5169.9 5172.5 5203.3 2610.3 2629.6 2636.4 2639.5 2651.9 5086.0 5093.7 5094.9 5105.4 5117.9 4910.9 5047.8 5054.7 5088.2 5156.6 5034.3 5081.5 5122.8 5138.5 5145.3 4925.4 4941.4 4946.3 4957.8 5007.6 4878.3 4914.1 5211.3 5549.3 5554.6 5831.9 5850.9 5852.2 5863.2 5875.6 3956.6 3995.1 4009.5 4016.1 4019.5 5325.8 5397.0 5571.4 5608.6 5692.3 5313.0 5432.8 5461.9 5468.6 5527.3 5486.5 5516.3 5523.5 5530.1 5548.8 5200.9 5415.2 5423.5 5452.8 5452.8 5507.4 5517.5 5521.8 5522.6 5542.6 5431.3 5458.9 5468.4 5485.4 5490.6 04:32:45 INFO - PROCESS | 6065 | 04:32:45 INFO - PROCESS | 6065 | [#5] yui.html Cycles:180 Average:21947.02 Median:4519.64 stddev:33047.00 (731.2%) stddev-sans-first:33101.25 04:32:45 INFO - PROCESS | 6065 | Values: 714.4 725.3 753.1 775.4 815.9 14380.4 14856.6 15230.0 15261.1 16633.9 13852.4 13857.7 13865.0 13974.1 14039.4 647.9 767.7 784.1 801.3 802.7 808.1 818.2 818.6 818.8 818.9 851.3 852.6 852.9 853.5 853.6 669.5 807.3 836.5 846.7 847.0 601.9 608.9 611.6 611.7 611.9 13929.5 13953.4 13954.4 13956.3 14035.2 13752.8 14084.3 14255.4 14291.5 14569.6 12708.0 12821.6 13063.2 13108.1 13110.9 4442.3 4464.7 4506.4 4517.3 4699.2 76243.0 77006.0 79760.6 79943.6 80541.0 10801.9 10910.7 10926.6 11011.8 11297.4 19176.2 19702.9 19764.5 20589.4 20628.3 8343.9 8351.7 8379.3 8398.4 8538.9 4522.0 4572.8 4690.0 4700.1 4715.9 2993.9 3097.2 3098.0 3132.9 3167.3 504.3 603.7 606.7 616.5 617.1 574.3 664.0 669.3 708.2 743.9 9306.7 9654.5 9953.5 9973.7 10149.7 572.8 652.5 680.1 720.8 731.3 4805.7 4890.2 4895.1 4926.4 4957.2 124274.0 125227.4 126950.4 126996.4 131123.0 106720.0 108511.5 109161.0 109714.0 116382.0 95221.5 95222.0 95678.5 98223.5 98354.0 8887.8 9242.6 9322.4 9375.0 9459.6 42287.6 53369.0 53591.7 55017.7 55947.4 75712.9 84033.0 85133.6 85177.6 85326.6 11258.6 11427.1 11471.3 11601.6 11900.7 12559.2 12705.3 12972.9 14656.6 15068.5 14382.1 14539.5 14650.4 14716.6 15232.2 12609.4 12746.7 12763.6 13601.4 13651.9 14175.3 14338.7 14652.2 15107.0 15139.5 10639.5 10991.3 11213.8 11420.1 11579.8 11352.5 11508.5 11526.2 11570.6 11742.5 04:32:45 INFO - PROCESS | 6065 | -------- Summary: end -------- 04:32:45 INFO - PROCESS | 6065 | 04:32:46 INFO - TEST-INFO | 6065: exit 0 04:32:46 INFO - TEST-OK | dromaeo_css | took 1113525ms 04:32:46 INFO - TEST-START | kraken 04:32:46 INFO - operating with platform_type : linux_ 04:32:46 INFO - Initialising browser for kraken test... 04:32:46 INFO - TEST-INFO | started process 6257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGZQA5o/profile http://localhost:38718/getInfo.html) 04:32:49 INFO - PROCESS | 6257 | __metrics Screen width/height:1600/1200 04:32:49 INFO - PROCESS | 6257 | colorDepth:24 04:32:49 INFO - PROCESS | 6257 | Browser inner width/height: 1024/697 04:32:49 INFO - PROCESS | 6257 | __metrics 04:32:50 INFO - PROCESS | 6257 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:51 INFO - TEST-INFO | 6257: exit 0 04:32:51 INFO - Browser initialized. 04:32:51 INFO - Running cycle 1/1 for kraken test... 04:32:51 INFO - TEST-INFO | started process 6339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGZQA5o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:03 INFO - PROCESS | 6339 | RSS: Main: 156946432 04:33:03 INFO - PROCESS | 6339 | 04:33:06 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38718/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:06 INFO - PROCESS | 6339 | RSS: Main: 214966272 04:33:06 INFO - PROCESS | 6339 | 04:33:09 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38718/tests/kraken/driver.html?testName=audio-dft) 04:33:10 INFO - PROCESS | 6339 | RSS: Main: 203194368 04:33:10 INFO - PROCESS | 6339 | 04:33:13 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38718/tests/kraken/driver.html?testName=audio-fft) 04:33:13 INFO - PROCESS | 6339 | RSS: Main: 268902400 04:33:13 INFO - PROCESS | 6339 | 04:33:15 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38718/tests/kraken/driver.html?testName=audio-oscillator) 04:33:16 INFO - PROCESS | 6339 | RSS: Main: 180281344 04:33:16 INFO - PROCESS | 6339 | 04:33:18 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38718/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:19 INFO - PROCESS | 6339 | RSS: Main: 184213504 04:33:19 INFO - PROCESS | 6339 | 04:33:22 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38718/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:22 INFO - PROCESS | 6339 | RSS: Main: 218992640 04:33:22 INFO - PROCESS | 6339 | 04:33:26 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38718/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:26 INFO - PROCESS | 6339 | RSS: Main: 221065216 04:33:26 INFO - PROCESS | 6339 | 04:33:29 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38718/tests/kraken/driver.html?testName=json-parse-financial) 04:33:30 INFO - PROCESS | 6339 | RSS: Main: 221134848 04:33:30 INFO - PROCESS | 6339 | 04:33:31 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38718/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:32 INFO - PROCESS | 6339 | RSS: Main: 208470016 04:33:32 INFO - PROCESS | 6339 | 04:33:34 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38718/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:34 INFO - PROCESS | 6339 | RSS: Main: 212738048 04:33:34 INFO - PROCESS | 6339 | 04:33:36 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38718/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:37 INFO - PROCESS | 6339 | RSS: Main: 209010688 04:33:37 INFO - PROCESS | 6339 | 04:33:39 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:40 INFO - PROCESS | 6339 | RSS: Main: 229494784 04:33:40 INFO - PROCESS | 6339 | 04:33:43 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:43 INFO - PROCESS | 6339 | RSS: Main: 224653312 04:33:43 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | Cycle 1(1): loaded http://localhost:38718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38718/tests/kraken/driver.html?testName=ai-astar) 04:33:45 INFO - PROCESS | 6339 | RSS: Main: 266493952 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | __start_tp_report 04:33:45 INFO - PROCESS | 6339 | _x_x_mozilla_page_load 04:33:45 INFO - PROCESS | 6339 | _x_x_mozilla_page_load_details 04:33:45 INFO - PROCESS | 6339 | |i|pagename|runs| 04:33:45 INFO - PROCESS | 6339 | |0;ai-astar;101;113;111;110;113;112;111;110;112;112 04:33:45 INFO - PROCESS | 6339 | |1;audio-beat-detection;145;120;119;182;117;118;141;116;163;117 04:33:45 INFO - PROCESS | 6339 | |2;audio-dft;161;159;159;159;160;161;160;161;162;161 04:33:45 INFO - PROCESS | 6339 | |3;audio-fft;75;76;75;130;74;75;73;74;98;75 04:33:45 INFO - PROCESS | 6339 | |4;audio-oscillator;83;83;117;84;85;83;132;85;83;141 04:33:45 INFO - PROCESS | 6339 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;118;117;118 04:33:45 INFO - PROCESS | 6339 | |6;imaging-darkroom;146;146;145;146;146;146;145;145;146;145 04:33:45 INFO - PROCESS | 6339 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;94;94 04:33:45 INFO - PROCESS | 6339 | |8;json-parse-financial;55;55;54;53;57;64;54;55;62;55 04:33:45 INFO - PROCESS | 6339 | |9;json-stringify-tinderbox;63;62;62;62;62;61;61;63;63;62 04:33:45 INFO - PROCESS | 6339 | |10;stanford-crypto-aes;81;75;75;75;80;75;74;74;74;79 04:33:45 INFO - PROCESS | 6339 | |11;stanford-crypto-ccm;136;121;118;119;119;119;121;119;159;128 04:33:45 INFO - PROCESS | 6339 | |12;stanford-crypto-pbkdf2;159;156;159;158;153;155;157;154;157;154 04:33:45 INFO - PROCESS | 6339 | |13;stanford-crypto-sha256-iterative;63;63;63;64;62;64;67;63;62;62 04:33:45 INFO - PROCESS | 6339 | __end_tp_report 04:33:45 INFO - PROCESS | 6339 | __start_cc_report 04:33:45 INFO - PROCESS | 6339 | _x_x_mozilla_cycle_collect,1671 04:33:45 INFO - PROCESS | 6339 | __end_cc_report 04:33:45 INFO - PROCESS | 6339 | __startTimestamp1467632025609__endTimestamp 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | ------- Summary: start ------- 04:33:45 INFO - PROCESS | 6339 | Number of tests: 14 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:1.13 04:33:45 INFO - PROCESS | 6339 | Values: 101.0 113.0 111.0 110.0 113.0 112.0 111.0 110.0 112.0 112.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:130.50 stddev:23.32 (17.9%) stddev-sans-first:24.38 04:33:45 INFO - PROCESS | 6339 | Values: 145.0 120.0 119.0 182.0 117.0 118.0 141.0 116.0 163.0 117.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 04:33:45 INFO - PROCESS | 6339 | Values: 161.0 159.0 159.0 159.0 160.0 161.0 160.0 161.0 162.0 161.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:18.25 (24.3%) stddev-sans-first:19.16 04:33:45 INFO - PROCESS | 6339 | Values: 75.0 76.0 75.0 130.0 74.0 75.0 73.0 74.0 98.0 75.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:83.00 stddev:23.09 (27.8%) stddev-sans-first:23.88 04:33:45 INFO - PROCESS | 6339 | Values: 83.0 83.0 117.0 84.0 85.0 83.0 132.0 85.0 83.0 141.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:33:45 INFO - PROCESS | 6339 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 118.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:33:45 INFO - PROCESS | 6339 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:33:45 INFO - PROCESS | 6339 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:55.00 stddev:3.66 (6.7%) stddev-sans-first:3.84 04:33:45 INFO - PROCESS | 6339 | Values: 55.0 55.0 54.0 53.0 57.0 64.0 54.0 55.0 62.0 55.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 04:33:45 INFO - PROCESS | 6339 | Values: 63.0 62.0 62.0 62.0 62.0 61.0 61.0 63.0 63.0 62.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.00 stddev:2.70 (3.6%) stddev-sans-first:2.24 04:33:45 INFO - PROCESS | 6339 | Values: 81.0 75.0 75.0 75.0 80.0 75.0 74.0 74.0 74.0 79.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:121.00 stddev:12.92 (10.7%) stddev-sans-first:13.18 04:33:45 INFO - PROCESS | 6339 | Values: 136.0 121.0 118.0 119.0 119.0 119.0 121.0 119.0 159.0 128.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:157.00 stddev:2.15 (1.4%) stddev-sans-first:2.03 04:33:45 INFO - PROCESS | 6339 | Values: 159.0 156.0 159.0 158.0 153.0 155.0 157.0 154.0 157.0 154.0 04:33:45 INFO - PROCESS | 6339 | 04:33:45 INFO - PROCESS | 6339 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.49 (2.4%) stddev-sans-first:1.58 04:33:45 INFO - PROCESS | 6339 | Values: 63.0 63.0 63.0 64.0 62.0 64.0 67.0 63.0 62.0 62.0 04:33:45 INFO - PROCESS | 6339 | -------- Summary: end -------- 04:33:45 INFO - PROCESS | 6339 | 04:33:46 INFO - TEST-INFO | 6339: exit 0 04:33:46 INFO - TEST-OK | kraken | took 60490ms 04:33:46 INFO - SUITE-END | took 1174s 04:33:46 INFO - Completed test suite (00:19:34) 04:33:46 INFO - javascript benchmark 04:33:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.0720783764873, 3097.2876238465137, 3135.576697145885, 3137.2784259620303, 3154.9211269718253, 5130.6152038597165, 5195.506426889449, 5217.739113044347, 5281.419043905172, 5317.840464786058, 5196.506331898473, 5211.817586384477, 5260.342457192851, 5277.6305658603915, 5300.151975683882, 4782.569568738812, 4827.63792715546, 4870.001649661811, 4874.512548745132, 5013.799448022093, 4924.926126108094, 4935.161022626162, 4946.0, 4998.2752500887345, 5011.799528018875, 4712.6229901607785, 4726.787294571753, 4742.264948932921, 4832.371791667061, 4838.903221935541, 4804.8318308859025, 4825.179719447702, 4905.828296009622, 4919.901601967977, 4965.950340496621, 4713.95286047142, 4858.587020103296, 4885.120678277908, 4903.411590609114, 4937.629677774145, 5146.716930568818, 5222.242774797671, 5224.9738751306, 5291.126964050927, 5300.09898317287, 5576.358718747315, 5640.943590564083, 5659.094544872842, 5666.9716651416475, 5673.063944449161, 5520.751566179531, 5567.137093750475, 5750.511206547449, 5827.737751801179, 5836.503897168745, 5229.869253268661, 5299.231611416361, 5322.946770532284, 5323.441038690959, 5331.120365139747, 5840.474357307863, 5858.853528661817, 5861.062230043172, 5864.824055278348, 5865.589408741433, 5243.239730239094, 5425.674459532441, 5466.644668096561, 5604.551635869121, 5609.887802243932, 5630.971845140748, 5634.3802181759975, 5638.746256418389, 5640.971795140998, 5645.5483561314995, 5574.58190635704, 5581.107022876401, 5581.274434323512, 5583.944160558423, 5625.043742563774, 5380.892382152413, 5585.553155747531, 5591.10542313228, 5640.717964101778, 5654.4062873398525, 4335.913281734411, 4355.455568053993, 4359.237133501624, 4364.148990946798, 4393.890152746143, 3842.1355195080882, 3860.7876566789096, 3877.86427475037, 3881.84472621092, 3900.941485877657, 5180.093483640348, 5184.015037142931, 5226.059309324358, 5245.606579506552, 5245.659032162897, 5568.415316391721, 5583.190437386556, 5592.524635406036, 5596.048671725735, 5632.802851900164, 5201.245819356248, 5261.053010458078, 5261.105612045962, 5265.4997775211295, 5300.602454815904, 4658.906821863544, 4659.743714095757, 4693.178693728652, 4698.7415692137265, 4714.976425117852, 5800.56495762811, 5806.88386232273, 5810.1865738796605, 5812.651240925558, 5814.302283725895, 5508.173773933942, 5578.525825304894, 5583.469570390806, 5593.244911936999, 5647.463490968352, 5875.618084824473, 5929.080992446177, 5934.821955341174, 5949.3753155918, 5968.76124954997, 5619.157126431068, 5634.6337488063145, 5641.097424412074, 5641.661500309994, 5646.943530564642, 5459.0, 5517.172424136412, 5719.428057194247, 5732.799352022659, 5745.798897038583, 5453.563714902719, 5487.368952570506, 5488.313960754906, 5491.807786727445, 5551.861203469945, 5423.29497165366, 5430.049741295178, 5467.753951072132, 5470.589705772003, 5471.151971444432, 5315.0964336063735, 5380.704061276668, 5411.567074634098, 5420.83737487876, 5447.754851031634, 5560.499555040065, 5577.051901176891, 5625.184348269396, 5626.409227031103, 5639.182318563868, 5399.136138217867, 5435.402105768283, 5446.891062178655, 5448.809291674773, 5450.700211488406], "value": 5202.356919794548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4471641373524, 611.9694015299235, 628.7453581299575, 632.5888172687755, 634.4987459906674, 31455.68544314556, 42392.36411453831, 43468.3479747804, 43600.56399436005, 43606.563934360645, 45583.31625025627, 45817.54182458174, 45862.31206531896, 46246.306305405444, 46276.53723462764, 8026.197380261986, 8984.236339911098, 9127.0, 9137.497437640926, 9137.63449462024, 10562.894371056307, 10840.186985976045, 10855.620053298137, 11180.552777888875, 11208.327500350006, 10950.233483656148, 11034.448277586129, 11051.834222486668, 11053.889461105407, 11057.0, 10680.732981675481, 10811.513481893333, 10812.080973117294, 10844.240903136784, 10850.0, 10843.295185812896, 10857.45712714369, 10893.0, 10909.672709818718, 10916.235863489559, 42007.579924200676, 42221.78889105566, 42354.78822605898, 42363.57636423658, 42365.788171059256, 3481.8085005324697, 3603.3694103531775, 3686.7972261525606, 3778.282126395976, 4058.553559108496, 33325.88831479517, 33366.33267334664, 33380.833095834605, 33714.49428258578, 34506.82746586276, 4509.346144808985, 4527.569880861313, 4646.83736069236, 4664.906701865978, 4692.389989301403, 339943.0, 342169.0, 342880.0, 343302.0, 344089.0, 59364.0, 59399.70300148472, 59648.0, 59807.700961495786, 59823.40176598266, 35240.82379588085, 36065.81967090148, 36141.277174456365, 37614.811925940194, 37616.0, 16797.160141992852, 16935.91532042332, 16976.40582579604, 16992.91503542499, 17002.234899429557, 11829.0, 12802.551910683082, 12988.675283117998, 13114.278714670594, 13201.40593673287, 19089.90455047716, 19243.134058967382, 19264.229430822612, 19283.807161928202, 19465.708014379794, 6799.150106236721, 7033.507654464139, 7053.0, 7068.575885446787, 7185.461090418239, 832.6586099699215, 894.9821003579892, 940.0787228516092, 976.5605477535138, 994.7861209839774, 32131.0, 32883.83558082242, 33161.66838331634, 33389.66610333914, 33496.83251583727, 1103.7351035751522, 1115.8382034604938, 1184.514349116858, 1214.4595654933646, 1262.1543565810746, 17423.47729568115, 17564.560885977953, 17596.472105836845, 17605.295788168587, 17617.0, 570327.0, 572122.0, 572597.0, 575856.0, 577554.0, 58264.70867645634, 58683.413165868646, 58751.0, 58760.0, 58782.82434351289, 1283.5058502476613, 1335.4057444437133, 1349.2376807103956, 1355.8915286777035, 1363.4341748174595, 31463.370732585678, 32079.839600801846, 32466.513002305455, 32506.349873001935, 32896.342073158885, 50125.49874501208, 50226.497735023644, 50540.24189637085, 50566.74716626394, 50632.493675062775, 475360.0, 477758.0, 478598.0, 478865.0, 479416.0, 24547.754522454547, 24915.750842492067, 25441.618375724007, 25510.87244563765, 28159.296017599725, 47794.5220547804, 48120.51879481161, 48255.517444825105, 48995.0, 49201.753991229816, 39854.60145398509, 40505.93675790526, 40742.0, 41031.0, 42020.1595968085, 40777.0, 41559.37660935028, 41571.0, 41630.0, 42355.364669529365, 40166.1966760669, 40551.1889762209, 40668.79665601653, 41129.79435102805, 41489.0, 35437.645623544464, 36274.0, 36898.0, 36982.63017369792, 36984.44523332206, 27866.721332786412, 28057.859710701316, 28153.0, 28198.43603127967, 28356.43287134287], "value": 20455.520829608264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.81241004317945, 392.3428257668406, 393.641785974763, 398.5735263268303, 417.74935038976616, 14645.6338591535, 18168.092350303225, 19130.521736956565, 20408.59182816343, 20415.693764593525, 14882.0, 17294.654106917853, 18231.817681823177, 19203.615927681472, 19514.0, 5599.692016939057, 5711.314642242936, 5730.7421166047625, 5735.6271842330325, 5764.279465066867, 4160.06398560323, 5617.691026993513, 5686.857828554278, 6112.69436528174, 6394.872102557946, 6388.616682999012, 6409.551331406803, 6425.839354016163, 6447.451966582846, 6454.838629034288, 6218.533609979247, 6381.744730210786, 6410.487161027107, 6417.518686098561, 6419.293877673452, 5454.945450545483, 5647.519960803336, 5649.717514124277, 5664.348599911022, 5666.716664166775, 22848.428789280235, 22960.540789184124, 23026.769732302797, 23100.306990790305, 23552.293431197093, 2301.1255722825385, 2444.9144279950115, 2603.8307510011787, 2779.0050586033294, 2798.0486634544354, 7216.386607138399, 7278.272172782732, 11425.571803524559, 14767.556973290819, 14781.630459238497, 1939.9612007759906, 1940.3790786948182, 1986.5232344237425, 1994.6409646263667, 2010.7084472751515, 51874.0, 54128.72935635297, 81116.59441702753, 82883.58558207231, 83768.58115709382, 10338.328008679562, 10379.84430233547, 10608.363498190134, 10840.403777792297, 11139.275947063416, 14781.48264810748, 14971.401143954337, 14981.0, 14981.850181498046, 15015.849841501664, 7968.0, 8222.301104406193, 8308.459950103224, 8416.621252043673, 8420.0, 7318.3047610476915, 8243.422960392714, 8291.917080829235, 8478.703245386381, 8487.660493580188, 6254.937450625526, 6444.613323200623, 6545.607263564201, 6599.53803233769, 6602.966985165043, 1851.1114664960626, 1866.496046067554, 1894.3843250943498, 1926.1428664244277, 1968.045497933501, 973.2116985241977, 994.8060128274917, 1037.5940600486383, 1097.3744965369663, 1117.2681893359863, 19781.0, 19862.801371986094, 19881.0, 19934.601307974048, 19937.0, 1001.4041645221082, 1003.4380746781826, 1039.750459889621, 1049.8425236214475, 1087.0162502934857, 10978.0, 11402.087832973508, 11481.540738370371, 11502.712432189095, 11508.19442639024, 447335.0, 462187.0, 477046.0, 477993.0, 478251.0, 79916.0, 80212.59893700611, 81013.59493202614, 81323.18676813156, 82344.58827705822, 988.5403287471361, 998.9300748947504, 1006.9949650251701, 1030.2015937648382, 1040.1262939131166, 17424.390146344816, 17797.911010444866, 17935.103244837966, 17964.10179490994, 18264.726029109308, 44590.3311450322, 44978.3253251195, 45093.54906451025, 45415.0, 45491.54508454873, 61504.384956149865, 61579.0, 62409.0, 62484.0, 63783.0, 7338.889916651147, 7378.557286562824, 7495.512791668524, 8328.417010809186, 8509.87235191485, 9240.306976976619, 12867.871321286668, 13208.537701180412, 13278.53525126616, 13537.1200871943, 11359.943200284277, 11733.706657333634, 11735.354555499529, 11740.979613026951, 11818.172727909308, 11764.470598822902, 11777.293362398283, 11792.351420671945, 11924.105692073303, 12026.436563246722, 11807.527698891949, 12003.939980300043, 12011.399430028638, 12054.517819287481, 12309.138360314691, 7487.288707572772, 7550.622468876644, 7599.734009309647, 7749.225077492206, 7902.802429939297, 10022.649207277711, 11988.580399685969, 12327.876721232673, 12400.0, 12436.316002619942], "value": 9331.463756229941, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.9669758256036, 1435.748743969805, 1458.132411215327, 1578.0610536730642, 1742.5643589102733, 8265.380096492765, 8618.181272779084, 8630.395872288942, 8645.74062778116, 8888.111188881125, 8047.718329858456, 8150.796230094251, 8565.057843637194, 8569.143085691428, 8575.271101956341, 1978.6834106542956, 2047.2322878920404, 2276.4877902471976, 2296.1274715608088, 2343.086196383403, 2331.6852224949585, 2355.128602417108, 2355.2345487716475, 2358.6697862299293, 2359.1389142962867, 2296.827737919663, 2307.065638416444, 2338.7895089441945, 2341.0869760793303, 2342.121704360865, 1938.9709154362695, 2135.8398120140896, 2144.8391370647187, 2204.382772823612, 2211.2702808073295, 2234.0, 2235.2623634200836, 2244.831637627168, 2248.640217565198, 2248.9437764055865, 8764.079771624016, 8878.11218878107, 8881.111888811132, 8894.555272236426, 8896.911030889672, 5056.696598204119, 5186.392218412304, 5224.686518808883, 5224.738763061831, 5227.8170264040955, 3254.4304746669236, 3260.836958152083, 3292.242784159657, 3323.1692076980753, 3359.7312215022985, 1101.1576144249655, 1117.2626066795876, 1121.1199208621192, 1123.0790751583704, 1138.8576427946507, 11730.35483048432, 11902.523899044028, 11938.28370297785, 11981.400929953468, 11999.52001919922, 4267.722598031118, 4414.977925110354, 4473.150101480708, 4555.544445555418, 4577.5193604671695, 10028.498575071364, 10030.047145521165, 10032.398056116657, 10040.598376065022, 10044.045815647502, 5089.720065396439, 5091.0581542414775, 5091.694498330112, 5094.2103973884105, 5094.261332106824, 4281.97859010703, 4714.245720684674, 4853.830115945925, 4856.757162141878, 4884.633652476078, 3920.784356860343, 3995.180987897474, 4010.7393019454225, 4125.566815484391, 4175.144095460423, 1153.377176324792, 1236.3756303066893, 1268.0, 1280.1103233252986, 1289.348878816192, 840.0843081041572, 887.1837909123622, 930.15356026016, 945.7493764152505, 966.840471322238, 6068.939310606926, 6134.8159555213415, 6299.149614802035, 6299.6535190564955, 6380.0748891410485, 969.3311614985637, 993.0218734546465, 994.8557459168525, 1003.5484032185545, 1007.219404961161, 4207.326827707552, 4265.7440553566885, 4314.892127696833, 4356.564343565681, 4367.061081867414, 10898.782024359469, 11222.0, 11274.098072154207, 11281.71795705114, 11307.830382544269, 10444.634437794793, 10776.0, 10809.56761729522, 11142.721431964266, 11189.384583847805, 8205.384596155312, 8295.087540370554, 8326.916730832736, 8338.541380224025, 8341.708040218564, 6148.200733904742, 6351.079093531504, 6375.298717141203, 6380.585261957958, 6409.359064093554, 10060.446675432922, 10269.743256418351, 10338.844917326396, 10342.5345859435, 10384.32501887375, 10366.481675916024, 10439.791204176026, 10505.78988420212, 10521.210909181995, 10543.051125398752, 7908.920910791048, 8022.679092836454, 8026.598670066356, 8028.518288902685, 8031.59842007909, 8335.541545215072, 8725.869111963453, 8731.34514911397, 8969.416987895765, 8983.685571004984, 7809.726659567115, 7813.609319534115, 7904.604769761374, 7938.841223175388, 8158.5920703963375, 7725.729599463992, 7751.806204844924, 7803.375729941705, 7886.802829929068, 7901.762947111596, 7357.5953322567775, 7376.041114655275, 7411.1477180124975, 7413.777586672409, 7433.92566074354, 5009.574186194214, 5048.949510504848, 5217.373915130209, 5240.502152295526, 5318.973405133104, 5411.188321751769, 5426.593005524523, 5473.890522189614, 5504.669719816664, 5649.6327738696855], "value": 4646.945381882368, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.34476736934, 324.8484123781195, 328.4252558023459, 333.28344060270416, 335.43311803052836, 5235.476452354767, 5251.291075704778, 5256.973715131419, 5306.310179676641, 5323.760430780614, 5006.4492905780335, 5045.243213517974, 5060.84817455476, 5126.641135120543, 5243.239730239113, 3958.2479328927557, 4033.2135233629456, 4124.731892426983, 4141.130362623852, 4180.456540649727, 4081.265372233012, 4140.648044916185, 4146.6268035876765, 4163.479565054368, 4168.62482376586, 3953.881383558498, 4113.745307681156, 4125.8968525786795, 4145.709800313979, 4151.252774500589, 4062.923325318793, 4067.5560176137637, 4080.816563196699, 4121.216968775923, 4134.317837556815, 3601.1717305019993, 3605.9819700901326, 3607.8917632471066, 3609.3864043112735, 3613.223157021253, 4858.951410485885, 5123.462036486189, 5130.769115389817, 5134.614903882224, 5140.203268493389, 4671.11248862715, 4694.600958918496, 4719.598834099105, 4724.220503616899, 4728.243481043051, 5422.0, 5432.809851655173, 5448.56411487084, 5459.563234941195, 5549.6115271930985, 3852.6339997700175, 3945.2109578084496, 3950.4271880577157, 3951.8221680024467, 3981.7610943343493, 5635.380108188096, 5643.714295710203, 5644.068728659766, 5664.348599911022, 5687.744051517691, 4033.153037862082, 4033.2135233629747, 4037.5356833963883, 4038.8990275243355, 4040.515138183378, 4112.259793237186, 4114.855980040684, 4118.320477121301, 4138.5654506276405, 4138.896527586834, 4525.705829121162, 4630.814767409266, 4634.745089020136, 4637.930431043537, 4648.6745927785405, 5404.243405923174, 5413.566914646819, 5418.241446197536, 5432.837014889559, 5525.309336332958, 1331.3276795218353, 1363.3387806913638, 1387.1607677355257, 1395.827504895872, 1402.2708191740237, 952.5618215620754, 954.4559601027487, 971.50453268832, 975.9414435133773, 977.7604486900613, 5131.0, 5152.789094562775, 5175.767090480862, 5191.558717509054, 5193.636445448858, 5452.291202143696, 5500.80747173855, 5514.6691198527415, 5516.668999860021, 5517.834464966058, 4913.5286888930905, 5168.948310516922, 5169.870753231199, 5172.456892026358, 5203.349581302337, 2610.3474131467133, 2629.6318515407856, 2636.419987602724, 2639.4792972711016, 2651.8939242430088, 5085.95737873735, 5093.719845408538, 5094.872628184251, 5105.387353517527, 5117.923231151536, 4910.852674419773, 5047.798088076509, 5054.69671819692, 5088.211327244283, 5156.561692256125, 5034.338668239399, 5081.526357356325, 5122.769475373617, 5138.460461651547, 5145.331106956071, 4925.433575138905, 4941.43173535048, 4946.307516947558, 4957.776900039579, 5007.649464537593, 4878.341423907727, 4914.108068393765, 5211.348581427322, 5549.250851135045, 5554.611177217717, 5831.912521312269, 5850.882982340415, 5852.215074402178, 5863.237779088691, 5875.618084824473, 3956.643902048829, 3995.08113133975, 4009.4587230723478, 4016.116454380032, 4019.4975628046495, 5325.813596524103, 5397.0, 5571.415001424954, 5608.6073974823, 5692.288463942007, 5313.0, 5432.837014889559, 5461.918071228855, 5468.644538105011, 5527.2538207341495, 5486.506214440719, 5516.310461192351, 5523.486813499928, 5530.142827861688, 5548.778048878, 5200.921986170135, 5415.2147938547905, 5423.511883930465, 5452.781888724407, 5452.836414907559, 5507.449255074621, 5517.503424691797, 5521.779128834963, 5522.641028333145, 5542.584306177134, 5431.34823821144, 5458.8908221834545, 5468.425815289337, 5485.369182544058, 5490.5882058844945], "value": 4104.95366943769, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.3677845107079, 725.3363172696982, 753.1489416958839, 775.4300589067038, 815.8735396013618, 14380.352884120213, 14856.628584285398, 15229.999999999985, 15261.084334939911, 16633.91683041583, 13852.445902163901, 13857.722845543083, 13865.0, 13974.09168404053, 14039.36822842972, 647.9384458476461, 767.7466436076081, 784.1374488063142, 801.3428988229625, 802.6909639788694, 808.0787901791962, 818.1859050245015, 818.55388813097, 818.8362327534517, 818.9017317921857, 851.2891735400948, 852.5779739029189, 852.9189726975927, 853.4623187391966, 853.6158728572136, 669.5279827721469, 807.2532907061004, 836.4730219961385, 846.699421705295, 846.9618867150962, 601.9006863867456, 608.9330173680892, 611.587178654411, 611.703323887914, 611.8776244751068, 13929.512467063603, 13953.3720982555, 13954.441822327095, 13956.302184890816, 14035.228062456561, 13752.793708094387, 14084.295785210801, 14255.358508867022, 14291.499797507142, 14569.635759106, 12708.0, 12821.551245706449, 13063.216207027608, 13108.082434229607, 13110.934445327712, 4442.267025940716, 4464.732116073046, 4506.369108324837, 4517.299818528133, 4699.154152252628, 76243.0, 77006.0, 79760.60119699422, 79943.60028199939, 80541.0, 10801.945990269998, 10910.72723181911, 10926.562937482411, 11011.83482247767, 11297.378644174485, 19176.232950682097, 19702.901485492766, 19764.505887352643, 20589.38231853047, 20628.27801026957, 8343.916560834436, 8351.749447516584, 8379.329653627818, 8398.370122240734, 8538.87191692125, 4521.977390113028, 4572.7713614319155, 4690.0, 4700.056903832512, 4715.858524244278, 2993.925151871221, 3097.241175911916, 3098.0, 3132.859021344045, 3167.255694911694, 504.2738456622452, 603.7343568829701, 606.6996836565928, 616.5006344860677, 617.139090968106, 574.319431473705, 663.986720265592, 669.3172963577124, 708.1855865754321, 743.9181690014094, 9306.72079837606, 9654.519168453091, 9953.502324883726, 9973.700788976343, 10149.695509134737, 572.782342709776, 652.4617190817595, 680.1124532485154, 720.8270015196315, 731.2541207967843, 4805.711657300573, 4890.1931181355385, 4895.094407534618, 4926.4088309403105, 4957.157283261854, 124274.0, 125227.3738631301, 126950.36524817502, 126996.36501817616, 131123.0, 106720.0, 108511.45744271229, 109161.0, 109714.0, 116382.0, 95221.5238923801, 95222.0, 95678.52160739152, 98223.50888245513, 98354.01645983591, 8887.777805554913, 9242.623827587115, 9322.440653560809, 9375.0, 9459.581062840629, 42287.577124228366, 53369.0, 53591.73204133954, 55017.72491137519, 55947.44052559585, 75712.86430703654, 84033.0, 85133.57433212794, 85177.57411212905, 85326.57336713276, 11258.605948791754, 11427.142964277878, 11471.311721296748, 11601.566002211677, 11900.702482438008, 12559.246445213317, 12705.301208433624, 12972.935135324264, 14656.633584160481, 15068.547943561272, 14382.137071775309, 14539.547966642605, 14650.413983440969, 14716.632084197981, 15232.238388080774, 12609.43257553394, 12746.68133296675, 12763.553275635308, 13601.387937542637, 13651.931740341632, 14175.291235438393, 14338.713225735219, 14652.19412932299, 15107.0, 15139.470118545798, 10639.521221544894, 10991.285566438157, 11213.775724485628, 11420.143489238175, 11579.826302605636, 11352.489137988645, 11508.53965841357, 11526.193166478266, 11570.59502917394, 11742.471588778697], "value": 7548.563847668969, "unit": "score"}], "name": "dromaeo_css", "value": 7231.438855490022, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 110.0, 113.0, 112.0, 111.0, 110.0, 112.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 119.0, 182.0, 117.0, 118.0, 141.0, 116.0, 163.0, 117.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 159.0, 159.0, 160.0, 161.0, 160.0, 161.0, 162.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 130.0, 74.0, 75.0, 73.0, 74.0, 98.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 84.0, 85.0, 83.0, 132.0, 85.0, 83.0, 141.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 53.0, 57.0, 64.0, 54.0, 55.0, 62.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 63.0, 63.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 75.0, 75.0, 80.0, 75.0, 74.0, 74.0, 74.0, 79.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 121.0, 118.0, 119.0, 119.0, 119.0, 121.0, 119.0, 159.0, 128.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 159.0, 158.0, 153.0, 155.0, 157.0, 154.0, 157.0, 154.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 62.0, 64.0, 67.0, 63.0, 62.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1482.4, "alertThreshold": 2.0}]} 04:33:46 INFO - Return code: 0 04:33:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:46 INFO - # TBPL SUCCESS # 04:33:46 INFO - Running post-action listener: _resource_record_post_action 04:33:46 INFO - ##### 04:33:46 INFO - ##### Finished run-tests step (success) 04:33:46 INFO - ##### 04:33:46 INFO - Running post-run listener: _resource_record_post_run 04:33:47 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 567222272; Read time: 272; Write time: 614692 04:33:47 INFO - TinderboxPrint: CPU usage
13.0% 04:33:47 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 272 04:33:47 INFO - TinderboxPrint: I/O write bytes / time
567,222,272 / 614,692 04:33:47 INFO - TinderboxPrint: CPU idle
8,275.4 (87.0%) 04:33:47 INFO - TinderboxPrint: CPU user
1,196.0 (12.6%) 04:33:47 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 269996032; Read time: 168; Write time: 346144 04:33:47 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297226240; Read time: 88; Write time: 268548 04:33:47 INFO - Running post-run listener: _upload_blobber_files 04:33:47 INFO - Blob upload gear active. 04:33:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:47 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 04:33:47 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:33:47 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:33:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:33:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:33:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:48 INFO - (blobuploader) - INFO - Done attempting. 04:33:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:33:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:33:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:49 INFO - (blobuploader) - INFO - Done attempting. 04:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:52 INFO - (blobuploader) - INFO - Done attempting. 04:33:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:52 INFO - Return code: 0 04:33:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed047e1f88820f46b0ef9ea19bdbe8a19dca0a0f866041dad631fe9844ee1c07f759a6d7f8f50d9e6313407e8445e36d84a69e1941c7990c43b340a7ac52dcf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7ded98a14749d22b5079522baf66a331fb3b7202f50dad5f4e6da8bfa64ec8bb8ba0bd1a14dd4b5d327d8f6c2553a3225209b437422edb55510183f1fcea499", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bfecad1837416f82b2a5ddac35a601f0bf18ff0bdc86bfa45e678b76d99aff1677bbee8e8fc98ea9cc019a984d6b596e59f3026a62487ea1e884d5ad798ec6d"} 04:33:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:52 INFO - Contents: 04:33:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed047e1f88820f46b0ef9ea19bdbe8a19dca0a0f866041dad631fe9844ee1c07f759a6d7f8f50d9e6313407e8445e36d84a69e1941c7990c43b340a7ac52dcf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7ded98a14749d22b5079522baf66a331fb3b7202f50dad5f4e6da8bfa64ec8bb8ba0bd1a14dd4b5d327d8f6c2553a3225209b437422edb55510183f1fcea499", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bfecad1837416f82b2a5ddac35a601f0bf18ff0bdc86bfa45e678b76d99aff1677bbee8e8fc98ea9cc019a984d6b596e59f3026a62487ea1e884d5ad798ec6d"} 04:33:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:52 INFO - Copying logs to upload dir... 04:33:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.796074 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-04 04:33:51.931101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 04:33:51.934727) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed047e1f88820f46b0ef9ea19bdbe8a19dca0a0f866041dad631fe9844ee1c07f759a6d7f8f50d9e6313407e8445e36d84a69e1941c7990c43b340a7ac52dcf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7ded98a14749d22b5079522baf66a331fb3b7202f50dad5f4e6da8bfa64ec8bb8ba0bd1a14dd4b5d327d8f6c2553a3225209b437422edb55510183f1fcea499", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bfecad1837416f82b2a5ddac35a601f0bf18ff0bdc86bfa45e678b76d99aff1677bbee8e8fc98ea9cc019a984d6b596e59f3026a62487ea1e884d5ad798ec6d"} build_url:https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/RjvOvvIeT1-zobCVCBuK3w/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/Mozilla-Inbound/sha512/ed047e1f88820f46b0ef9ea19bdbe8a19dca0a0f866041dad631fe9844ee1c07f759a6d7f8f50d9e6313407e8445e36d84a69e1941c7990c43b340a7ac52dcf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7ded98a14749d22b5079522baf66a331fb3b7202f50dad5f4e6da8bfa64ec8bb8ba0bd1a14dd4b5d327d8f6c2553a3225209b437422edb55510183f1fcea499", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bfecad1837416f82b2a5ddac35a601f0bf18ff0bdc86bfa45e678b76d99aff1677bbee8e8fc98ea9cc019a984d6b596e59f3026a62487ea1e884d5ad798ec6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 04:33:51.965116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 04:33:51.965487) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467624059.944284-801599626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004708 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 04:33:52.051236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 04:33:52.051986) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 04:33:52.052746) ========= ========= Total master_lag: 0.18 =========