builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1469014532.55 results: success (0) buildid: 20160720013036 builduid: 92b3603a998244b5af413bbdef96adbf revision: 59d21113b4619c117c178b86ec8c7fd5d7fb5807 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:32.549348) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:32.549820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:32.550096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:32.564421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:32.564716) ========= 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=0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 04:35:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-07-20 04:35:32 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:32.682190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:32.682515) ========= 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=0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018947 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:32.732610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 04:35:32.732990) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 59d21113b4619c117c178b86ec8c7fd5d7fb5807 --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 59d21113b4619c117c178b86ec8c7fd5d7fb5807 --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=0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 04:35:33,093 truncating revision to first 12 chars 2016-07-20 04:35:33,093 Setting DEBUG logging. 2016-07-20 04:35:33,093 attempt 1/10 2016-07-20 04:35:33,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/59d21113b461?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 04:35:33,855 unpacking tar archive at: mozilla-inbound-59d21113b461/testing/mozharness/ program finished with exit code 0 elapsedTime=1.158517 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 04:35:33.905201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:33.905543) ========= script_repo_revision: 59d21113b4619c117c178b86ec8c7fd5d7fb5807 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:33.905935) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:33.906207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 04:35:33.915880) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-20 04:35:33.916214) ========= /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=0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:35:34 INFO - MultiFileLogger online at 20160720 04:35:34 in /builds/slave/test 04:35:34 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:35:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:34 INFO - {'append_to_log': False, 04:35:34 INFO - 'base_work_dir': '/builds/slave/test', 04:35:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:35:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:34 INFO - 'branch': 'Mozilla-Inbound', 04:35:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:34 INFO - 'config_files': ('talos/linux_config.py',), 04:35:34 INFO - 'default_actions': ('clobber', 04:35:34 INFO - 'read-buildbot-config', 04:35:34 INFO - 'download-and-extract', 04:35:34 INFO - 'populate-webroot', 04:35:34 INFO - 'create-virtualenv', 04:35:34 INFO - 'install', 04:35:34 INFO - 'run-tests'), 04:35:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:34 INFO - 'download_minidump_stackwalk': True, 04:35:34 INFO - 'download_symbols': 'ondemand', 04:35:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:34 INFO - 'installer_path': 'installer.exe', 04:35:34 INFO - 'log_level': 'info', 04:35:34 INFO - 'log_name': 'talos', 04:35:34 INFO - 'log_to_console': True, 04:35:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:35:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:35:34 INFO - 'opt_config_files': (), 04:35:34 INFO - 'pip_index': False, 04:35:34 INFO - 'sps_profile': False, 04:35:34 INFO - 'sps_profile_interval': 0, 04:35:34 INFO - 'suite': 'dromaeojs', 04:35:34 INFO - 'system_bits': '32', 04:35:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:34 INFO - 'title': 'talos-linux64-ix-017', 04:35:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:34 INFO - 'use_talos_json': True, 04:35:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:34 INFO - 'work_dir': 'build'} 04:35:34 INFO - ##### 04:35:34 INFO - ##### Running clobber step. 04:35:34 INFO - ##### 04:35:34 INFO - Running pre-action listener: _resource_record_pre_action 04:35:34 INFO - Running main action method: clobber 04:35:34 INFO - rmtree: /builds/slave/test/build 04:35:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:35:35 INFO - Running post-action listener: _resource_record_post_action 04:35:35 INFO - ##### 04:35:35 INFO - ##### Finished clobber step (success) 04:35:35 INFO - ##### 04:35:35 INFO - ##### 04:35:35 INFO - ##### Running read-buildbot-config step. 04:35:35 INFO - ##### 04:35:35 INFO - Running pre-action listener: _resource_record_pre_action 04:35:35 INFO - Running main action method: read_buildbot_config 04:35:35 INFO - Using buildbot properties: 04:35:35 INFO - { 04:35:35 INFO - "project": "", 04:35:35 INFO - "product": "firefox", 04:35:35 INFO - "script_repo_revision": "production", 04:35:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:35:35 INFO - "repository": "", 04:35:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:35:35 INFO - "buildid": "20160720013036", 04:35:35 INFO - "pgo_build": "True", 04:35:35 INFO - "basedir": "/builds/slave/test", 04:35:35 INFO - "buildnumber": 2095, 04:35:35 INFO - "slavename": "talos-linux64-ix-017", 04:35:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:35:35 INFO - "platform": "ubuntu64_hw", 04:35:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:35:35 INFO - "branch": "mozilla-inbound", 04:35:35 INFO - "repo_path": "integration/mozilla-inbound", 04:35:35 INFO - "revision": "59d21113b4619c117c178b86ec8c7fd5d7fb5807", 04:35:35 INFO - "stage_platform": "linux64-pgo", 04:35:35 INFO - "builduid": "92b3603a998244b5af413bbdef96adbf", 04:35:35 INFO - "slavebuilddir": "test" 04:35:35 INFO - } 04:35:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:35:35 INFO - Running post-action listener: _resource_record_post_action 04:35:35 INFO - ##### 04:35:35 INFO - ##### Finished read-buildbot-config step (success) 04:35:35 INFO - ##### 04:35:35 INFO - ##### 04:35:35 INFO - ##### Running download-and-extract step. 04:35:35 INFO - ##### 04:35:35 INFO - Running pre-action listener: _resource_record_pre_action 04:35:35 INFO - Running main action method: download_and_extract 04:35:35 INFO - mkdir: /builds/slave/test/build/tests 04:35: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:35:35 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:35:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:35:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:35:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:36 INFO - Downloaded 1361 bytes. 04:35:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:35:36 INFO - Using the following test package requirements: 04:35:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:35:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:35:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:35:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:36 INFO - u'jsshell-linux-x86_64.zip'], 04:35:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:35:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:35:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:35:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:35:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:35:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:35:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:35:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:36 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:35:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:35:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:35:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:38 INFO - Downloaded 24339941 bytes. 04:35:38 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:35:38 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:35:40 INFO - Return code: 0 04:35:40 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:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:40 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:35:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:41 INFO - Downloaded 24339941 bytes. 04:35:41 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:35:41 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:35:42 INFO - Return code: 0 04:35:42 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:35:42 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:35:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:35:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:35:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:43 INFO - Downloaded 14403317 bytes. 04:35:43 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:35:43 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:35:43 INFO - Return code: 0 04:35: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:35:43 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:35:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:35:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:35:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:35:45 INFO - Downloaded 60870793 bytes. 04:35:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:35:45 INFO - mkdir: /builds/slave/test/properties 04:35:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:35:45 INFO - Writing to file /builds/slave/test/properties/build_url 04:35:45 INFO - Contents: 04:35:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:35:45 INFO - Running post-action listener: _resource_record_post_action 04:35:45 INFO - Running post-action listener: set_extra_try_arguments 04:35:45 INFO - ##### 04:35:45 INFO - ##### Finished download-and-extract step (success) 04:35:45 INFO - ##### 04:35:45 INFO - ##### 04:35:45 INFO - ##### Running populate-webroot step. 04:35:45 INFO - ##### 04:35:45 INFO - Running pre-action listener: _resource_record_pre_action 04:35:45 INFO - Running main action method: populate_webroot 04:35:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:35:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:35:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:35:46 INFO - '--tppagecycles', 04:35:46 INFO - '7'], 04:35:46 INFO - 'tests': ['tsvgm']}}, 04:35:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:35:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:35:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:35:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:35:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:46 INFO - 'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:46 INFO - 'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['damp', 'tps']}, 04:35:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:46 INFO - 'tests': ['damp', 'tps']}, 04:35:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['dromaeo_dom']}, 04:35:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:35:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['basic_compositor_video']}, 04:35:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:35:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['a11yr', 04:35:46 INFO - 'ts_paint', 04:35:46 INFO - 'tpaint', 04:35:46 INFO - 'sessionrestore', 04:35:46 INFO - 'sessionrestore_no_auto_restore', 04:35:46 INFO - 'tabpaint']}, 04:35:46 INFO - 'other-e10s': {'tests': ['a11yr', 04:35:46 INFO - 'ts_paint', 04:35:46 INFO - 'tpaint', 04:35:46 INFO - 'sessionrestore', 04:35:46 INFO - 'sessionrestore_no_auto_restore', 04:35:46 INFO - 'tabpaint']}, 04:35:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:35:46 INFO - 'ts_paint', 04:35:46 INFO - 'tpaint', 04:35:46 INFO - 'sessionrestore', 04:35:46 INFO - 'sessionrestore_no_auto_restore', 04:35:46 INFO - 'tabpaint']}, 04:35:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:35:46 INFO - 'ts_paint', 04:35:46 INFO - 'tpaint', 04:35:46 INFO - 'sessionrestore', 04:35:46 INFO - 'sessionrestore_no_auto_restore', 04:35:46 INFO - 'tabpaint']}, 04:35:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['a11yr', 04:35:46 INFO - 'ts_paint', 04:35:46 INFO - 'tpaint', 04:35:46 INFO - 'sessionrestore', 04:35:46 INFO - 'sessionrestore_no_auto_restore', 04:35:46 INFO - 'tabpaint']}, 04:35:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['a11yr', 04:35:46 INFO - 'ts_paint', 04:35:46 INFO - 'tpaint', 04:35:46 INFO - 'sessionrestore', 04:35:46 INFO - 'sessionrestore_no_auto_restore', 04:35:46 INFO - 'tabpaint']}, 04:35:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['tsvgx', 04:35:46 INFO - 'tsvgr_opacity', 04:35:46 INFO - 'tart', 04:35:46 INFO - 'tscrollx', 04:35:46 INFO - 'cart']}, 04:35:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:35:46 INFO - 'tsvgr_opacity', 04:35:46 INFO - 'tart', 04:35:46 INFO - 'tscrollx', 04:35:46 INFO - 'cart']}, 04:35:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:46 INFO - 'talos_options': ['--disable-e10s'], 04:35:46 INFO - 'tests': ['tp5o']}, 04:35:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:46 INFO - 'tests': ['tp5o']}, 04:35:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:46 INFO - 'talos_options': ['--disable-e10s', 04:35:46 INFO - '--xperf_path', 04:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:46 INFO - 'tests': ['tp5n']}, 04:35:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:46 INFO - 'talos_options': ['--xperf_path', 04:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:46 INFO - 'tests': ['tp5n']}}, 04:35:46 INFO - 'talos.zip': {'path': '', 04:35:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:35:46 INFO - Running post-action listener: _resource_record_post_action 04:35:46 INFO - ##### 04:35:46 INFO - ##### Finished populate-webroot step (success) 04:35:46 INFO - ##### 04:35:46 INFO - ##### 04:35:46 INFO - ##### Running create-virtualenv step. 04:35:46 INFO - ##### 04:35:46 INFO - Running pre-action listener: _resource_record_pre_action 04:35:46 INFO - Running main action method: create_virtualenv 04:35:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:35:46 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:35:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:35:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:35:46 INFO - Using real prefix '/usr' 04:35:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:35:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:35:48 INFO - Installing pip.................done. 04:35:48 INFO - Return code: 0 04:35:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:35:48 INFO - Using env: {'DISPLAY': ':0', 04:35:48 INFO - 'HOME': '/home/cltbld', 04:35:48 INFO - 'LANG': 'en_US.UTF-8', 04:35:48 INFO - 'LANGUAGE': 'en_US:en', 04:35:48 INFO - 'LOGNAME': 'cltbld', 04:35:48 INFO - 'MAIL': '/var/mail/cltbld', 04:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:48 INFO - 'MOZ_NO_REMOTE': '1', 04:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:48 INFO - 'NO_EM_RESTART': '1', 04:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:48 INFO - 'PWD': '/builds/slave/test', 04:35:48 INFO - 'SHELL': '/bin/bash', 04:35:48 INFO - 'SHLVL': '1', 04:35:48 INFO - 'TERM': 'linux', 04:35:48 INFO - 'TMOUT': '86400', 04:35:48 INFO - 'USER': 'cltbld', 04:35:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:48 INFO - '_': '/tools/buildbot/bin/python'} 04:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:48 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:35:48 INFO - Cleaning up... 04:35:48 INFO - Return code: 0 04:35:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:35:48 INFO - Using env: {'DISPLAY': ':0', 04:35:48 INFO - 'HOME': '/home/cltbld', 04:35:48 INFO - 'LANG': 'en_US.UTF-8', 04:35:48 INFO - 'LANGUAGE': 'en_US:en', 04:35:48 INFO - 'LOGNAME': 'cltbld', 04:35:48 INFO - 'MAIL': '/var/mail/cltbld', 04:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:48 INFO - 'MOZ_NO_REMOTE': '1', 04:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:48 INFO - 'NO_EM_RESTART': '1', 04:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:48 INFO - 'PWD': '/builds/slave/test', 04:35:48 INFO - 'SHELL': '/bin/bash', 04:35:48 INFO - 'SHLVL': '1', 04:35:48 INFO - 'TERM': 'linux', 04:35:48 INFO - 'TMOUT': '86400', 04:35:48 INFO - 'USER': 'cltbld', 04:35:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:48 INFO - '_': '/tools/buildbot/bin/python'} 04:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:48 INFO - Downloading/unpacking psutil>=3.1.1 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:51 INFO - Installing collected packages: psutil 04:35:51 INFO - Running setup.py install for psutil 04:35:51 INFO - building 'psutil._psutil_linux' extension 04:35:51 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:35:51 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:35:51 INFO - building 'psutil._psutil_posix' extension 04:35:51 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:35:51 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:35:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:51 INFO - Successfully installed psutil 04:35:51 INFO - Cleaning up... 04:35:51 INFO - Return code: 0 04:35:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:35:51 INFO - Using env: {'DISPLAY': ':0', 04:35:51 INFO - 'HOME': '/home/cltbld', 04:35:51 INFO - 'LANG': 'en_US.UTF-8', 04:35:51 INFO - 'LANGUAGE': 'en_US:en', 04:35:51 INFO - 'LOGNAME': 'cltbld', 04:35:51 INFO - 'MAIL': '/var/mail/cltbld', 04:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:51 INFO - 'MOZ_NO_REMOTE': '1', 04:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:51 INFO - 'NO_EM_RESTART': '1', 04:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:51 INFO - 'PWD': '/builds/slave/test', 04:35:51 INFO - 'SHELL': '/bin/bash', 04:35:51 INFO - 'SHLVL': '1', 04:35:51 INFO - 'TERM': 'linux', 04:35:51 INFO - 'TMOUT': '86400', 04:35:51 INFO - 'USER': 'cltbld', 04:35:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:51 INFO - '_': '/tools/buildbot/bin/python'} 04:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:35:53 INFO - Installing collected packages: mozsystemmonitor 04:35:53 INFO - Running setup.py install for mozsystemmonitor 04:35:53 INFO - Successfully installed mozsystemmonitor 04:35:53 INFO - Cleaning up... 04:35:53 INFO - Return code: 0 04:35:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:53 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 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:35:53 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:35:53 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:35:53 INFO - Using env: {'DISPLAY': ':0', 04:35:53 INFO - 'HOME': '/home/cltbld', 04:35:53 INFO - 'LANG': 'en_US.UTF-8', 04:35:53 INFO - 'LANGUAGE': 'en_US:en', 04:35:53 INFO - 'LOGNAME': 'cltbld', 04:35:53 INFO - 'MAIL': '/var/mail/cltbld', 04:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:53 INFO - 'MOZ_NO_REMOTE': '1', 04:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:53 INFO - 'NO_EM_RESTART': '1', 04:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:53 INFO - 'PWD': '/builds/slave/test', 04:35:53 INFO - 'SHELL': '/bin/bash', 04:35:53 INFO - 'SHLVL': '1', 04:35:53 INFO - 'TERM': 'linux', 04:35:53 INFO - 'TMOUT': '86400', 04:35:53 INFO - 'USER': 'cltbld', 04:35:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:53 INFO - '_': '/tools/buildbot/bin/python'} 04:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:54 INFO - Downloading/unpacking jsonschema==2.5.1 04:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:56 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:56 INFO - warning: no files found matching '*.txt' 04:35:56 INFO - no previously-included directories found matching 'build' 04:35:56 INFO - no previously-included directories found matching 'dist' 04:35:56 INFO - no previously-included directories found matching '.git*' 04:35:56 INFO - Installing collected packages: jsonschema, functools32 04:35:56 INFO - Running setup.py install for functools32 04:35:56 INFO - warning: no files found matching '*.txt' 04:35:56 INFO - no previously-included directories found matching 'build' 04:35:56 INFO - no previously-included directories found matching 'dist' 04:35:56 INFO - no previously-included directories found matching '.git*' 04:35:56 INFO - Successfully installed jsonschema functools32 04:35:56 INFO - Cleaning up... 04:35:56 INFO - Return code: 0 04:35:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:35:56 INFO - Using env: {'DISPLAY': ':0', 04:35:56 INFO - 'HOME': '/home/cltbld', 04:35:56 INFO - 'LANG': 'en_US.UTF-8', 04:35:56 INFO - 'LANGUAGE': 'en_US:en', 04:35:56 INFO - 'LOGNAME': 'cltbld', 04:35:56 INFO - 'MAIL': '/var/mail/cltbld', 04:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:56 INFO - 'MOZ_NO_REMOTE': '1', 04:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:56 INFO - 'NO_EM_RESTART': '1', 04:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:56 INFO - 'PWD': '/builds/slave/test', 04:35:56 INFO - 'SHELL': '/bin/bash', 04:35:56 INFO - 'SHLVL': '1', 04:35:56 INFO - 'TERM': 'linux', 04:35:56 INFO - 'TMOUT': '86400', 04:35:56 INFO - 'USER': 'cltbld', 04:35:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:56 INFO - '_': '/tools/buildbot/bin/python'} 04:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:59 INFO - Downloading docopt-0.6.1.tar.gz 04:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:59 INFO - Running setup.py install for blobuploader 04:35:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:59 INFO - Running setup.py install for requests 04:35:59 INFO - Running setup.py install for docopt 04:35:59 INFO - Successfully installed blobuploader requests docopt 04:35:59 INFO - Cleaning up... 04:36:00 INFO - Return code: 0 04:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:00 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:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:00 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:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:00 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 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:36:00 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:36:00 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:36:00 INFO - Using env: {'DISPLAY': ':0', 04:36:00 INFO - 'HOME': '/home/cltbld', 04:36:00 INFO - 'LANG': 'en_US.UTF-8', 04:36:00 INFO - 'LANGUAGE': 'en_US:en', 04:36:00 INFO - 'LOGNAME': 'cltbld', 04:36:00 INFO - 'MAIL': '/var/mail/cltbld', 04:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:00 INFO - 'MOZ_NO_REMOTE': '1', 04:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:00 INFO - 'NO_EM_RESTART': '1', 04:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:00 INFO - 'PWD': '/builds/slave/test', 04:36:00 INFO - 'SHELL': '/bin/bash', 04:36:00 INFO - 'SHLVL': '1', 04:36:00 INFO - 'TERM': 'linux', 04:36:00 INFO - 'TMOUT': '86400', 04:36:00 INFO - 'USER': 'cltbld', 04:36:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:00 INFO - '_': '/tools/buildbot/bin/python'} 04:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:00 INFO - Running setup.py (path:/tmp/pip-8pyOTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:00 INFO - Running setup.py (path:/tmp/pip-hW5NY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:00 INFO - Running setup.py (path:/tmp/pip-cgDX81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:00 INFO - Running setup.py (path:/tmp/pip-y3KNzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:00 INFO - Running setup.py (path:/tmp/pip-ZQct3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:00 INFO - Running setup.py (path:/tmp/pip-QUlwDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:00 INFO - Running setup.py (path:/tmp/pip-HVu8BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:00 INFO - Running setup.py (path:/tmp/pip-L8RfY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:00 INFO - Running setup.py (path:/tmp/pip-lho9aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:00 INFO - Running setup.py (path:/tmp/pip-r8sFAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:00 INFO - Running setup.py (path:/tmp/pip-ZrUIOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:01 INFO - Running setup.py (path:/tmp/pip-QfX2LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:01 INFO - Running setup.py (path:/tmp/pip-evmgS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:01 INFO - Running setup.py (path:/tmp/pip-Ldhc03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:01 INFO - Running setup.py (path:/tmp/pip-uhj2ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:01 INFO - Running setup.py (path:/tmp/pip-u1R9aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:01 INFO - Running setup.py (path:/tmp/pip-ig8shv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:01 INFO - Running setup.py install for manifestparser 04:36:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:01 INFO - Running setup.py install for mozcrash 04:36:01 INFO - Running setup.py install for mozdebug 04:36:01 INFO - Running setup.py install for mozdevice 04:36:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:01 INFO - Running setup.py install for mozfile 04:36:02 INFO - Running setup.py install for mozhttpd 04:36:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozinfo 04:36:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozInstall 04:36:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozleak 04:36:02 INFO - Running setup.py install for mozlog 04:36:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for moznetwork 04:36:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozprocess 04:36:02 INFO - Running setup.py install for mozprofile 04:36:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozrunner 04:36:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozscreenshot 04:36:03 INFO - Running setup.py install for moztest 04:36:03 INFO - Running setup.py install for mozversion 04:36:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:03 INFO - Cleaning up... 04:36:03 INFO - Return code: 0 04:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:03 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 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:36:03 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:36:03 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:36:03 INFO - Using env: {'DISPLAY': ':0', 04:36:03 INFO - 'HOME': '/home/cltbld', 04:36:03 INFO - 'LANG': 'en_US.UTF-8', 04:36:03 INFO - 'LANGUAGE': 'en_US:en', 04:36:03 INFO - 'LOGNAME': 'cltbld', 04:36:03 INFO - 'MAIL': '/var/mail/cltbld', 04:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:03 INFO - 'MOZ_NO_REMOTE': '1', 04:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:03 INFO - 'NO_EM_RESTART': '1', 04:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:03 INFO - 'PWD': '/builds/slave/test', 04:36:03 INFO - 'SHELL': '/bin/bash', 04:36:03 INFO - 'SHLVL': '1', 04:36:03 INFO - 'TERM': 'linux', 04:36:03 INFO - 'TMOUT': '86400', 04:36:03 INFO - 'USER': 'cltbld', 04:36:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:03 INFO - '_': '/tools/buildbot/bin/python'} 04:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:03 INFO - Running setup.py (path:/tmp/pip-2iTg9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:03 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:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:03 INFO - Running setup.py (path:/tmp/pip-2hnHQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:03 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:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:03 INFO - Running setup.py (path:/tmp/pip-atMdDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:03 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:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:03 INFO - Running setup.py (path:/tmp/pip-k2otW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:03 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:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:03 INFO - Running setup.py (path:/tmp/pip-uul_rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:03 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:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:03 INFO - Running setup.py (path:/tmp/pip-F5rPZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:03 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:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:03 INFO - Running setup.py (path:/tmp/pip-YFA9VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:04 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:04 INFO - Running setup.py (path:/tmp/pip-tZuIs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:04 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:04 INFO - Running setup.py (path:/tmp/pip-a3mjy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:04 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:04 INFO - Running setup.py (path:/tmp/pip-njxUlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:04 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:04 INFO - Running setup.py (path:/tmp/pip-SoLgWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:04 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:04 INFO - Running setup.py (path:/tmp/pip-wIzOyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:04 INFO - Running setup.py (path:/tmp/pip-TpynVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:04 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:04 INFO - Running setup.py (path:/tmp/pip-28Vw9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:04 INFO - Running setup.py (path:/tmp/pip-kutml8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:04 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:04 INFO - Running setup.py (path:/tmp/pip-I9bv2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:04 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:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:04 INFO - Running setup.py (path:/tmp/pip-nSRfL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:04 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:36:04 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:36:04 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:36:04 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:36:04 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:36:04 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:36:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:04 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:36:04 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:36:04 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:36:04 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:36:04 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:36:04 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:36:06 INFO - Downloading blessings-1.6.tar.gz 04:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:06 INFO - Installing collected packages: blessings 04:36:06 INFO - Running setup.py install for blessings 04:36:06 INFO - Successfully installed blessings 04:36:06 INFO - Cleaning up... 04:36:06 INFO - Return code: 0 04:36:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:07 INFO - Reading from file tmpfile_stdout 04:36:07 INFO - Current package versions: 04:36:07 INFO - argparse == 1.2.1 04:36:07 INFO - blessings == 1.6 04:36:07 INFO - blobuploader == 1.2.4 04:36:07 INFO - docopt == 0.6.1 04:36:07 INFO - functools32 == 3.2.3-2 04:36:07 INFO - jsonschema == 2.5.1 04:36:07 INFO - manifestparser == 1.1 04:36:07 INFO - mozInstall == 1.12 04:36:07 INFO - mozcrash == 0.17 04:36:07 INFO - mozdebug == 0.1 04:36:07 INFO - mozdevice == 0.48 04:36:07 INFO - mozfile == 1.2 04:36:07 INFO - mozhttpd == 0.7 04:36:07 INFO - mozinfo == 0.9 04:36:07 INFO - mozleak == 0.1 04:36:07 INFO - mozlog == 3.2 04:36:07 INFO - moznetwork == 0.27 04:36:07 INFO - mozprocess == 0.23 04:36:07 INFO - mozprofile == 0.28 04:36:07 INFO - mozrunner == 6.12 04:36:07 INFO - mozscreenshot == 0.1 04:36:07 INFO - mozsystemmonitor == 0.3 04:36:07 INFO - moztest == 0.7 04:36:07 INFO - mozversion == 1.4 04:36:07 INFO - psutil == 3.1.1 04:36:07 INFO - requests == 1.2.3 04:36:07 INFO - wsgiref == 0.1.2 04:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:07 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:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:07 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:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:07 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 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:36:07 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:36:07 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:36:07 INFO - Using env: {'DISPLAY': ':0', 04:36:07 INFO - 'HOME': '/home/cltbld', 04:36:07 INFO - 'LANG': 'en_US.UTF-8', 04:36:07 INFO - 'LANGUAGE': 'en_US:en', 04:36:07 INFO - 'LOGNAME': 'cltbld', 04:36:07 INFO - 'MAIL': '/var/mail/cltbld', 04:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:07 INFO - 'MOZ_NO_REMOTE': '1', 04:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:07 INFO - 'NO_EM_RESTART': '1', 04:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:07 INFO - 'PWD': '/builds/slave/test', 04:36:07 INFO - 'SHELL': '/bin/bash', 04:36:07 INFO - 'SHLVL': '1', 04:36:07 INFO - 'TERM': 'linux', 04:36:07 INFO - 'TMOUT': '86400', 04:36:07 INFO - 'USER': 'cltbld', 04:36:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:07 INFO - '_': '/tools/buildbot/bin/python'} 04:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:07 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:36:07 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:36:07 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:36:07 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:36:07 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:36:07 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:36:07 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:36:07 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:36:07 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:36:07 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:36:07 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:36:07 INFO - Cleaning up... 04:36:07 INFO - Return code: 0 04:36:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36:07 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:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:07 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:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:07 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 0x1fb5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2276180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, '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': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', '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:36:07 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:36:07 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:36:07 INFO - Using env: {'DISPLAY': ':0', 04:36:07 INFO - 'HOME': '/home/cltbld', 04:36:07 INFO - 'LANG': 'en_US.UTF-8', 04:36:07 INFO - 'LANGUAGE': 'en_US:en', 04:36:07 INFO - 'LOGNAME': 'cltbld', 04:36:07 INFO - 'MAIL': '/var/mail/cltbld', 04:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:07 INFO - 'MOZ_NO_REMOTE': '1', 04:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:07 INFO - 'NO_EM_RESTART': '1', 04:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:07 INFO - 'PWD': '/builds/slave/test', 04:36:07 INFO - 'SHELL': '/bin/bash', 04:36:07 INFO - 'SHLVL': '1', 04:36:07 INFO - 'TERM': 'linux', 04:36:07 INFO - 'TMOUT': '86400', 04:36:07 INFO - 'USER': 'cltbld', 04:36:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:07 INFO - '_': '/tools/buildbot/bin/python'} 04:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:07 INFO - Cleaning up... 04:36:07 INFO - Return code: 0 04:36:07 INFO - Running post-action listener: _resource_record_post_action 04:36:07 INFO - Running post-action listener: _start_resource_monitoring 04:36:07 INFO - Starting resource monitoring. 04:36:07 INFO - ##### 04:36:07 INFO - ##### Finished create-virtualenv step (success) 04:36:07 INFO - ##### 04:36:07 INFO - ##### 04:36:07 INFO - ##### Running install step. 04:36:07 INFO - ##### 04:36:07 INFO - Running pre-action listener: _resource_record_pre_action 04:36:07 INFO - Running main action method: install 04:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:07 INFO - Reading from file tmpfile_stdout 04:36:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:07 INFO - Reading from file tmpfile_stdout 04:36:07 INFO - Output received: 04:36:07 INFO - Usage: mozinstall [options] installer 04:36:07 INFO - Options: 04:36:07 INFO - -h, --help show this help message and exit 04:36:07 INFO - -d DEST, --destination=DEST 04:36:07 INFO - Directory to install application into. [default: 04:36:07 INFO - "/builds/slave/test"] 04:36:07 INFO - --app=APP Application being installed. [default: firefox] 04:36:07 INFO - mkdir: /builds/slave/test/build/application 04:36:07 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:36:07 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:36:25 INFO - Reading from file tmpfile_stdout 04:36:25 INFO - Output received: 04:36:25 INFO - /builds/slave/test/build/application/firefox/firefox 04:36:25 INFO - Running post-action listener: _resource_record_post_action 04:36:25 INFO - ##### 04:36:25 INFO - ##### Finished install step (success) 04:36:25 INFO - ##### 04:36:25 INFO - ##### 04:36:25 INFO - ##### Running run-tests step. 04:36:25 INFO - ##### 04:36:25 INFO - Running pre-action listener: _resource_record_pre_action 04:36:25 INFO - Running main action method: run_tests 04:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:36:25 INFO - Python 2.7.3 04:36:25 INFO - Return code: 0 04:36:25 INFO - grabbing minidump binary from tooltool 04:36:25 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:36:25 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 0x22743b0>, '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 0x22752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2275740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:36:25 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:36:25 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:36:25 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:36:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:25 INFO - Return code: 0 04:36:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:36:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:36:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:36:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:36:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:36:25 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/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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:36:25 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/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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:36:25 INFO - Using env: {'DISPLAY': ':0', 04:36:25 INFO - 'HOME': '/home/cltbld', 04:36:25 INFO - 'LANG': 'en_US.UTF-8', 04:36:25 INFO - 'LANGUAGE': 'en_US:en', 04:36:25 INFO - 'LOGNAME': 'cltbld', 04:36:25 INFO - 'MAIL': '/var/mail/cltbld', 04:36:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:36:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:25 INFO - 'MOZ_NO_REMOTE': '1', 04:36:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:25 INFO - 'NO_EM_RESTART': '1', 04:36:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:25 INFO - 'PWD': '/builds/slave/test', 04:36:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:36:25 INFO - 'SHELL': '/bin/bash', 04:36:25 INFO - 'SHLVL': '1', 04:36:25 INFO - 'TERM': 'linux', 04:36:25 INFO - 'TMOUT': '86400', 04:36:25 INFO - 'USER': 'cltbld', 04:36:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391', 04:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:25 INFO - '_': '/tools/buildbot/bin/python'} 04:36:25 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/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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:36:25 INFO - mozversion application_buildid: 20160720013036 04:36:25 INFO - mozversion application_changeset: 59d21113b4619c117c178b86ec8c7fd5d7fb5807 04:36:25 INFO - mozversion application_display_name: Nightly 04:36:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:25 INFO - mozversion application_name: Firefox 04:36:25 INFO - mozversion application_remotingname: firefox 04:36:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:36:25 INFO - mozversion application_vendor: Mozilla 04:36:25 INFO - mozversion application_version: 50.0a1 04:36:25 INFO - mozversion platform_buildid: 20160720013036 04:36:25 INFO - mozversion platform_changeset: 59d21113b4619c117c178b86ec8c7fd5d7fb5807 04:36:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:36:25 INFO - mozversion platform_version: 50.0a1 04:36:25 INFO - using testdate: 1469014585 04:36:25 INFO - actual date: 1469014585 04:36:25 INFO - starting webserver on 'localhost:46866' 04:36:25 INFO - SUITE-START | Running 2 tests 04:36:25 INFO - TEST-START | dromaeo_css 04:36:25 INFO - operating with platform_type : linux_ 04:36:25 INFO - Initialising browser for dromaeo_css test... 04:36:25 INFO - TEST-INFO | started process 5124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH_aE2t/profile http://localhost:46866/getInfo.html) 04:36:29 INFO - PROCESS | 5124 | __metrics Screen width/height:1600/1200 04:36:29 INFO - PROCESS | 5124 | colorDepth:24 04:36:29 INFO - PROCESS | 5124 | Browser inner width/height: 1024/697 04:36:29 INFO - PROCESS | 5124 | __metrics 04:36:29 INFO - PROCESS | 5124 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:36:29 INFO - PROCESS | 5124 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:36:30 INFO - TEST-INFO | 5124: exit 0 04:36:30 INFO - Browser initialized. 04:36:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:36:30 INFO - TEST-INFO | started process 5209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH_aE2t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:42 INFO - PROCESS | 5209 | RSS: Main: 157483008 04:36:42 INFO - PROCESS | 5209 | 04:37:33 INFO - PROCESS | 5209 | 1469014653733 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:39:40 INFO - PROCESS | 5209 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46866/tests/dromaeo/cssquery-ext.html) 04:39:42 INFO - PROCESS | 5209 | RSS: Main: 200339456 04:39:42 INFO - PROCESS | 5209 | 04:42:45 INFO - PROCESS | 5209 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-ext.html (next: http://localhost:46866/tests/dromaeo/cssquery-jquery.html) 04:42:45 INFO - PROCESS | 5209 | RSS: Main: 244297728 04:42:45 INFO - PROCESS | 5209 | 04:45:47 INFO - PROCESS | 5209 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46866/tests/dromaeo/cssquery-mootools.html) 04:45:48 INFO - PROCESS | 5209 | RSS: Main: 189681664 04:45:48 INFO - PROCESS | 5209 | 04:48:50 INFO - PROCESS | 5209 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46866/tests/dromaeo/cssquery-prototype.html) 04:48:50 INFO - PROCESS | 5209 | RSS: Main: 225701888 04:48:50 INFO - PROCESS | 5209 | 04:51:53 INFO - PROCESS | 5209 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46866/tests/dromaeo/cssquery-yui.html) 04:51:54 INFO - PROCESS | 5209 | RSS: Main: 192413696 04:51:54 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-yui.html (next: http://localhost:46866/tests/dromaeo/cssquery-dojo.html) 04:54:57 INFO - PROCESS | 5209 | RSS: Main: 270786560 04:54:57 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | __start_tp_report 04:54:57 INFO - PROCESS | 5209 | _x_x_mozilla_page_load 04:54:57 INFO - PROCESS | 5209 | _x_x_mozilla_page_load_details 04:54:57 INFO - PROCESS | 5209 | |i|pagename|runs| 04:54:57 INFO - PROCESS | 5209 | |0;dojo.html;3008.7743419243557;3042.4979878320078;3061.800982936108;3075.3388021575383;3109.2382366320253;5295.682259064449;5319.6276260661725;5349.251104845324;5395.649282796616;5453.836384908449;5285.365756109272;5343.305370301865;5357.517823395893;5409.9459005409935;5440.782368705257;4717.669763116592;4765.189917713979;4781.852355434688;4783.6890602110925;5035.0685123252315;4924.70451772893;4934.309196712463;4974.303597496335;4992.251162325662;5005.224190250498;4690.90618187636;4803.447603525587;4817.590504807095;4836.395450568679;4901.509849015088;4736.455307639597;4740.265258884879;4741.905161896777;4766.237402015696;4853.126437241295;4754.9341777698055;4786.712797232142;4805.951940480621;4812.157872372356;4834.395700537433;5179.7410129493755;5207.427183009866;5209.1665333546825;5231.607629427808;5332.946670533283;5592.161175823619;5623.156526521014;5633.971830140823;5634.098544232903;5634.408387119375;5675.943240567624;5676.858078548028;5685.232493613351;5696.3733989261145;5699.088145896637;5195;5305.4164041955355;5349.037173308841;5352.892942141136;5428.5114339708825;5908.793192238337;5913.142594323799;5913.793017244376;5919.763209471573;5920.407959204132;5639.464250896158;5683.744231509592;5686.346070201897;5694.316681998104;5700.486956173964;5564.109742441271;5638.633488823213;5678.403767604342;5679.716014199274;5789.942100579025;5695.572832037614;5704.401037891044;5709.286339207599;5711.600187986801;5711.628744131618;5681.318241811009;5716.256886604715;5721.199032135504;5735.225744524436;5739.253896993364;4213.136307057046;4313.590208930209;4348.108637729258;4358.760268185217;4422.049259409242;3895.6299151580556;3899.629535194152;3908.843646254175;3934.9213015740097;3939.3106206414336;5427.185922111715;5434.538064264502;5436.21174929633;5437.564994800407;5442.591805614595;5522.751476183581;5701.087825947829;5739.995500787346;5774.509166720792;5836.708164591753;5439.945600543944;5441.646292990943;5466.562674985991;5476.561875050066;5514.035043867307;4959.504049595083;4968.056069346812;4968.130577149057;4973.527514886152;5018.172001619765;5713.371529131792;5749.770009199585;5821.883562328814;5926.762929482772;5941.257342832146;5643.435656434323;5643.492085712305;5645.491905728504;5690.118031705092;5706.258186435737;5769.365369809401;5802.332731735735;5814.447627475383;5819.883602328015;5824.970875145597;5500.752466138953;5538.972305138448;5545.639533430314;5552.805651802168;5554.08357620988;5685.374608793112;5705.286839145107;5711.029125048834;5720.656760594377;5721.771129154788;5590.105583106683;5604.943950560442;5605.887882242414;5605.971970140124;5611.466910643482;5576.163575463713;5578.330600327987;5581.916271255853;5583.302087239095;5585.162225666182;5423.3491980962535;5527.39198688152;5558.527525160245;5571.13647384656;5572.749226284908;5483.780648774164;5548.611597188319;5574.024545704567;5584.190292407659;5588.41321661236;5349.812756553502;5396.271503347155;5402.081646120248;5403;5403.621746477709 04:54:57 INFO - PROCESS | 5209 | |1;ext.html;604.8669292755594;628.4124343738605;632.8291361332438;648.3484098481026;654.725015493493;43064.56935430645;44928.3260751089;44996.32505512416;45001.77499112508;47854;45064.09871802562;45583;45633.771831140795;45690.77154614231;45702.77148614261;9004.68483603074;9122.498262595554;9126.315526335518;9151.816963660756;9152.679656212034;8967.41711788735;9027.864582031274;9049.547522623876;9054.456732596032;9057.184853363196;9054.547272636375;9080.273578113734;9083.545822708871;9091.681791137311;9095.272378209727;9041.3671043027;9069.95465022674;9078.818423631556;9080.500572468512;9087.454752714826;8978.50618215998;9027.097290270985;9032.367734258605;9047.366684332099;9051.7284481465;43088.3536746949;43478.78260608709;43527.782361088306;43582.564174358165;43602.345964810556;3599.6400359963795;3666.9190309212486;3786.5266841644793;3803.6386543278345;3843.0392401899526;31578.842105789554;33608.663913361044;33634.49548256778;33681.49477757836;33681.663183368095;4345.174416860787;4488.820447182109;4523.864284071483;4532.138893610204;4562.110388474249;388159;388396;389729;390042;390664.32674856245;56107;56383.43616563782;56542.7172864133;56718;56853.71573142108;65700.74394048465;65793.6710316455;65894.67052664801;65938.67030664816;65967;16292.674146517003;16469.505914822574;16473.258703358377;16500.092494912897;16537;12500.749985000431;12528.060395470377;12571.559995400117;12578.433970471351;12585.24488530691;19363.51591210203;19662.90168549148;19752.40742777719;19872.50318742043;19965.602407831313;6670.194813623965;6955;6957.304269573002;7025.7353676337725;7143.678534465961;934.5187228577288;1047;1066.0192622787054;1080.6271836216492;1150.2408410449063;32889.17777055593;32912;33001;33106.834465828;33751.493727594105;1124.5220781168134;1134.9943250283861;1169.9941500292614;1194.7252132009687;1206.9921615451021;17075.658486830194;17313.3940312091;17318.307267709402;17440.953542787473;17481.47555573335;519256;522778;523662;523768;524865;60729;60796.69601652052;61026;61369;61423.69288153531;1241.0629974369294;1338.6385675867461;1365.808786769853;1382.2328607622867;1396.84634690184;32247.516287256178;34093.31813363669;34182;34414.31171376609;34496.827515862264;49955;50494.49505505045;50554.49445505498;50579;50636.49363506465;384320;384545;386355;386423;387058;24944.376390589656;27052.594211087242;27938;28592.14223573296;28755.5686664696;47677.28484072811;48524;48593;49000.754996224794;49032;40152.397714034894;41097.794511027256;41708.58291417168;41790.37314440225;43411.78294108509;40921.59078409297;41395.379069314586;41807.45895877735;42163.578364215966;42234.5776542243;35408;41009.38485922654;41070.79464602658;41565;41625;35354.64645353617;37522.437163442024;37950.54901336829;37981.810090949366;38294;27492.762825672493;27725.584116237867;27969.72030279671;28177;28246.43507129805 04:54:57 INFO - PROCESS | 5209 | |2;jquery.html;374.3654505612987;398.587461976854;398.7308566717466;407.08203002229965;418.5500586869115;14201.289935503222;17712.645747085066;19728.506787330323;19739.210431582756;19868.105935232914;19211.231550737954;19306;19493;19529.41411757646;19713.507162320948;5483.588730845193;5510.752016159262;5609.439056094398;5680.744366503496;5710.029295019835;5613.298337707786;5624.3531993820625;5624.718764061801;5651.124075768242;5655.236543066695;5413.242146099549;5572.3034620672415;5607.102863541834;5614.719264036802;5628.662280263176;5572.275604171452;5598.048331783607;5603.579731520153;5607.915881261764;5612.186232996192;4870.6103511718975;4991.675541089818;5017;5048.444671086178;5048.873778155539;23219.651705224434;23220.65169022466;23274;23444;23586.76413235863;2196.3191410662744;2357.139644029934;2441.8901149448316;2579.445419234855;2714.4164004739077;14013.579592612237;14156.221407822566;14349.354279057468;14482.42070317186;14664.560063198121;1819;1919.9904000480049;1942.5143714071482;1970.103602860695;1976.1502553901817;78383.6080819598;79337.60331198365;79603;80080.59959700222;82155;9384.57769400365;9775.902240977499;9991.300608957303;10133.898661013443;10154.492275386201;13217;13234.338283086;13282.601521954357;13298.468061277441;13398.789199781926;7664.693412263447;7762.184970578121;7822;7846.5292082475235;7954.164812694584;7722.382209423233;7801.375889928792;7829.138794732575;7943.602819858984;8109.189081091961;3975.7813320267082;3984.8007599620482;3991.7006224533275;3995.980020099939;4118.073433477443;1956.2761778142178;1961.7940116287584;1980.5345743750206;2032.2277534536781;2074.543600407908;948.7865230323122;959.8128364968765;984.0356450678232;1044.5090807320548;1068.759529105945;19893.403197903797;20303.289384871754;20314.390568282975;20475.59048819045;20752.169913203303;1002.3584905660383;1005.6982905128432;1013.310948554975;1078.8381742738652;1093.2292733622935;10484.475776211159;11088.5564577416;11225.887741122484;11285.322880627189;11334.433278336215;512480;519788;529062;530081;530761;93723.53138234265;95781;97365.51317243368;98797.50601246947;108619;998.1914649134225;1016.7559785651538;1053.878803937557;1054.5465449856636;1054.757405796671;17669.293228270726;18094.909525452287;18504.907475462536;18555;18840.152193151065;30340.54489182708;31922.84038579792;36094.09764755902;37327.44008839815;45735.54264457446;57780.4221957775;58478.415215848996;58541;63855.680721596094;65112.34887651063;8593.699220527502;8727.258183054511;8839.911600884167;8856.601452934505;9057.77355566116;11202.719932001439;13362.599122026355;13545.729085418434;13628.931855341056;13695.452181913011;11211.71970700739;11766.882331176921;11772.117091218022;11811.527538898348;12263.632091037283;10864.837027444753;11033.779324413626;11309.943450282695;11456.742812091468;11485.540578376771;11790.351530665552;11852.525898963944;11992.040636748865;12114.21257618252;12329.198602090835;8453.577321134042;8626.360991411611;8872.955635221782;8914;9009.369344145847;11225.438728063727;11545.307281563133;11899.82150267764;12083.033357331216;12088.456019479321 04:54:57 INFO - PROCESS | 5209 | |3;mootools.html;1289.2973329535403;1437.0443654969442;1464.3190916223953;1576.3615735627075;1749.8075211726707;7952.363810895129;8300.50196988181;8312.127226641207;8322.583870806458;8473.95763021184;8347.332213422927;8488.405811593191;8525.91474085259;8527.658893644262;8532.445391049578;1947.980520194794;2199.2082850174006;2269.706267427567;2310.861348319106;2312.2022902098747;2308.2036697339477;2334.48641298914;2334.8015418689433;2337.2170322941834;2339.2865176121277;2265.728112626479;2296.6095763720123;2307.9729520363444;2310.2260742651233;2310.549442858643;1901.3915547024958;2132.76539580646;2216.5345277491747;2219.123446238743;2220.4781876259067;2096.5073207796154;2124.787521247863;2126.4683829042738;2129.4889226585665;2130.243763463979;8422.326213902874;8504.447210931332;8515.74452766418;8520.360972927056;8522.65909363631;4897.314375987365;4984.27727979441;4990.575801056914;4990.575801056914;4998.7250701211415;3122.2506598416217;3280.78674886134;3309.0238379678053;3317.369699757063;3321.8173000484962;1032.4270030133273;1071.2501249125564;1089.9073578745815;1114.7881902438592;1123.1913022623698;11561.248518846249;11765.058795296442;11789.882101178964;11804.468798903985;11814.232074915102;4374.256376415953;4434.689571730012;4451.221036318631;4482.843100491467;4569.474510431343;10013.49932503372;10031.097201251923;10066.597336106473;10070.144037756872;10075.64735234278;5020;5059.443461219263;5062.7468626568525;5063.518965698253;5067.366579177603;4138.586141385837;4549.249373853278;4624.075184962953;4636.536346365404;4692.718436893797;3889.649931506178;3938.1729836734607;4010.6791456683395;4038.3134867072667;4066.79666016698;1249.4127759952808;1250.1249125612107;1255.215490318551;1269.0418733856063;1281.9423125959354;829.8921140251729;846.4328899637258;921.6175287255713;967.4243824924159;982.1933997398099;5775.711214439261;5825.592208545361;5848.1227815827115;5967.6419414835245;6080.726367313481;425.86372360844234;435.5513820764618;444.85764555342627;470.9034647897173;488.36024807502287;4206.20082184384;4242.809073591696;4274.636655884223;4307.203167413976;4319.740815551014;10336.379817210991;10552.577896884191;10620.097291730135;10623.575056997788;10629.5216715248;9938.403695778277;10378.688639340831;10396.064354208158;10589.258751887448;10689.198310126772;7879.684812607432;8002.639881205243;8046.275835174863;8062.999999999883;8064.153263907323;6005.849853753691;6069.787557435468;6090.177825993434;6102.9694851525455;6285.937140628535;9905.653302134391;9925.3548519346;9979.501024948579;9981.700548983543;10023.899761002296;9730.659426920023;9995;10043.548040338348;10138.49307534635;10147.543360548645;7667.118281397487;7786.4938778979185;7862.72480463181;7876.763697089096;7887;8290.170982901904;8312.459690120122;8363.66545338204;8368.958155209186;8380.58097095155;7289.307515785992;7308.926910731037;7346.118465783927;7383.556986580822;7587.393008559412;7269.672864720995;7346.889796652948;7375.889361659687;7434.256574342522;7444.255574442513;6913.3777959983845;7001.754938577125;7012.859742805217;7012.894806578008;7024.086868707035;5040.546350828443;5210.713410762444;5294.788208471618;5372.946270537401;5442;5279.102552565996;5345.4654534546235;5422.972885135549;5489.39616642177;5558.360788509373 04:54:57 INFO - PROCESS | 5209 | |4;prototype.html;329.09827073817735;333.1687439837604;340.8585437043627;350.26269702276704;353.0467737109801;5084.491550844914;5213.8957220855655;5285.392179899312;5351.973240133799;5362.865928351793;5165.225216217569;5181.3057210250645;5236.240745091959;5245.134552798793;5274.92087618686;4171.520275168349;4174.436451079104;4181.247375472413;4181.540030596632;4183.058811767359;3975.940360894589;4117.979410102946;4175.102352994106;4186.267403204442;4196.769177695225;4107.219628270634;4111.917761644765;4112.794360281989;4114.732542384751;4115.485564304462;4080.9795951020205;4102.343625020012;4120.69241224915;4122.587741225883;4123.628873401408;3658.7804731716183;3661.963380366189;3665.816709164531;3675.5773086095173;3683.631636836322;5080.5681517070725;5145.871353216199;5149.45930677281;5152.536271735525;5161.458046905059;4750.857474275777;4767.904641907143;4784.976075119602;4787.0904528139545;4794.736289504076;5441.129419292894;5547.55619550435;5553.527950124244;5563.693996830173;5566.053770858964;3982.76534274373;3988.3219852625125;3995.440638310639;4002.399640054015;4025.6175663311938;5633.8591535211535;5641.041023026054;5649.350324712628;5675.063614503602;5680.971595141998;4074.714769966074;4077.4087757275624;4087.4073259377224;4094.28350038742;4100;4029.435878976946;4049.190161967618;4109.876703698894;4122;4136.5935581902295;4672.205725026685;4691.3432119503295;4694.788734506956;4695.389599352063;4718.2214934536105;5464.808731694372;5474.507294343528;5501.724913754297;5565.443455654402;5578.967890940189;1289.471316760124;1339.819124418191;1421.1544131241894;1421.509579195176;1421.6730152065084;939.5208443693765;966.1884017425397;981;985.2561316206362;993.3344659078434;5194.1429664105;5231.529162375405;5241.816536421207;5243;5266.104762190437;5525.917111243334;5576.852911629052;5594.832155035356;5600.439956004367;5603.719814009365;4985.551300382983;5122.564582010571;5208.687478751287;5244.580433565306;5260.158374660113;2609.6868375795025;2627.868606569702;2648.298200976743;2655.853928033977;2665.986670066676;5103.260027296022;5123.513266239701;5155.845324640267;5169.741512924414;5179.067767801756;4751.885410992076;5064;5066.316047333637;5079.949200507947;5119;5109.616778741609;5110.233464980282;5114.360704911886;5193.662411943212;5193.974030129825;5005.649604527648;5040.773165207501;5060.797568097235;5073.351160872805;5078.873028174326;4815.518448155157;4891.26631005352;4898.24077268024;4916.92624610624;4929.728864912321;5031.949680503295;5108.8249702569365;5109.591232701449;5116.720819795051;5154.458781827854;3760.8307626157434;3864.30442520349;3934.4688467057726;4001.8599349022643;4029.1135950090934;5520.282363292747;5600.43995600453;5601.327840659147;5619;5631.521320687787;5448.237246785532;5465.262189604353;5488.560915126701;5488.862778430571;5526.806561770319;5249.186376111708;5369.301990741179;5371.221172929982;5389.8113566025;5389.946100538945;5307.65500242483;5370.382406023357;5380.354357477127;5391.409534187345;5488.835334939959;5371.462853714754;5458.972705136449;5475.835724928259;5494.725263736717;5527.861803454945;5275.525202731773;5289.57683385336;5307.283516725192;5315.601329900195;5343.530529104527 04:54:57 INFO - PROCESS | 5209 | |5;yui.html;768.9269519395656;770.3721467004391;800.2197857089335;833.1418638802032;846.1369403208731;15038.248087595617;15434.536963891087;15468.303926323315;15469;15668.451604193855;14743.705125897475;14895.92552037241;14897.329620167091;14905.850941490582;14919.92540037301;650.6974256970508;775.244136966456;784.0982869699848;796.7729197178805;801.6352559585404;789.4355535791908;804.2078552625659;807.5881300536739;808.4421748993205;808.6482380164617;850.4982060584254;851.7955690634234;853.3471894001094;853.4111463090479;854.5513605357175;692.2005084127841;706.0433113131684;848.3722045686179;848.9405741598091;849.570966661838;516.6460974232625;607.32890156377;619.69634878909;621.2669050520384;629.0093103362223;13795.241261730702;13813.171209727449;13823.861761382357;13873.930630346784;14092.224927628977;12935.288559129243;12955.805662915063;14251.358688859027;14284.285785710777;14309.28453577317;12781.488740450372;13169.209847409185;13172.736545269137;13199.340032998312;13277.402516886763;4394.318880573516;4490.416245888046;4496.303073023654;4498.572635599613;4572.454211001258;76063;76123.61938190329;76139.61930190369;76626.61686691531;77167.99999999943;10403.791924161475;10667.666541682289;10693;10710.839337409945;10747.301425407324;21051.78948210498;21084.262050828147;21101.78898211029;21108.47228819292;21132;8197.426180167331;8325.250727434439;8514.233718965199;8535.274501667303;8559.657613695506;4711.976440117777;4998.5751211146735;5003.574696150868;5018.096742586296;5047.041062198171;3388.796672199676;3455.982720086434;3511.0871173494565;3511.8244087795506;3515.0333658244185;579.0879365000058;583.201014609987;589.0369246282273;597.7847974729094;612.5712001598898;641.2433328672118;668;679.7722762874394;714.1323292200002;724.6087112959049;9093;9385.296102792181;9425.622975081056;9518.809623807485;9526.285528585384;666.3503084492678;684.1584850633649;699.6991293743637;713.8679344321214;740.4853626729372;4573.2911398732585;4728.243481043017;4853.9029219415415;4904.485029071968;5370.865728356823;119847.40076299563;124662;124981.79750850273;126739.36630316789;129080.3545982264;103403.48298258461;105897;106031.99999999846;107790.46104769583;109776;94089;95088;95096.52451737697;96783;97430.51284743531;10278.948605256926;10548.683539493828;10591.629292974709;10650.97631450022;10661.41362225054;52290.21564676609;52349.47650523446;53265.46734532605;54917.1762423556;55123;76575.61712191404;82434.17565824265;83885.16114838774;84989.57505212435;86963.1303686955;13968.511102111377;14010.299485025911;14025.3688584016;14429.134251944917;14678.77981830252;15267.618309542351;15738.527844164693;15910.284037218122;15957.361705532114;16046.518604441886;14068.788968165281;14398.640033999234;14723.926380368459;14912.925435372754;15056.397744090114;14302.57092287233;14532.927335363256;14625.92687036558;14927.850721492647;15075.19097708282;12865.421056052688;13354.86645133575;13579.932100339434;14042.648933776738;14730.852691472948;11958.64124076279;12428.502859885502;12440.409752709918;12453.626391207916;12755;10640.787184256116;10886.61896833607;11823.645290641294;12210.816837747263;12519.624411267676 04:54:57 INFO - PROCESS | 5209 | __end_tp_report 04:54:57 INFO - PROCESS | 5209 | __start_cc_report 04:54:57 INFO - PROCESS | 5209 | _x_x_mozilla_cycle_collect,1692 04:54:57 INFO - PROCESS | 5209 | __end_cc_report 04:54:57 INFO - PROCESS | 5209 | __startTimestamp1469015697469__endTimestamp 04:54:57 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | ------- Summary: start ------- 04:54:57 INFO - PROCESS | 5209 | Number of tests: 6 04:54:57 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | [#0] dojo.html Cycles:165 Average:5289.80 Median:5514.04 stddev:601.13 (10.9%) stddev-sans-first:575.73 04:54:57 INFO - PROCESS | 5209 | Values: 3008.8 3042.5 3061.8 3075.3 3109.2 5295.7 5319.6 5349.3 5395.6 5453.8 5285.4 5343.3 5357.5 5409.9 5440.8 4717.7 4765.2 4781.9 4783.7 5035.1 4924.7 4934.3 4974.3 4992.3 5005.2 4690.9 4803.4 4817.6 4836.4 4901.5 4736.5 4740.3 4741.9 4766.2 4853.1 4754.9 4786.7 4806.0 4812.2 4834.4 5179.7 5207.4 5209.2 5231.6 5332.9 5592.2 5623.2 5634.0 5634.1 5634.4 5675.9 5676.9 5685.2 5696.4 5699.1 5195.0 5305.4 5349.0 5352.9 5428.5 5908.8 5913.1 5913.8 5919.8 5920.4 5639.5 5683.7 5686.3 5694.3 5700.5 5564.1 5638.6 5678.4 5679.7 5789.9 5695.6 5704.4 5709.3 5711.6 5711.6 5681.3 5716.3 5721.2 5735.2 5739.3 4213.1 4313.6 4348.1 4358.8 4422.0 3895.6 3899.6 3908.8 3934.9 3939.3 5427.2 5434.5 5436.2 5437.6 5442.6 5522.8 5701.1 5740.0 5774.5 5836.7 5439.9 5441.6 5466.6 5476.6 5514.0 4959.5 4968.1 4968.1 4973.5 5018.2 5713.4 5749.8 5821.9 5926.8 5941.3 5643.4 5643.5 5645.5 5690.1 5706.3 5769.4 5802.3 5814.4 5819.9 5825.0 5500.8 5539.0 5545.6 5552.8 5554.1 5685.4 5705.3 5711.0 5720.7 5721.8 5590.1 5604.9 5605.9 5606.0 5611.5 5576.2 5578.3 5581.9 5583.3 5585.2 5423.3 5527.4 5558.5 5571.1 5572.7 5483.8 5548.6 5574.0 5584.2 5588.4 5349.8 5396.3 5402.1 5403.0 5403.6 04:54:57 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | [#1] ext.html Cycles:180 Average:60053.08 Median:41985.52 stddev:115690.33 (275.5%) stddev-sans-first:115928.77 04:54:57 INFO - PROCESS | 5209 | Values: 604.9 628.4 632.8 648.3 654.7 43064.6 44928.3 44996.3 45001.8 47854.0 45064.1 45583.0 45633.8 45690.8 45702.8 9004.7 9122.5 9126.3 9151.8 9152.7 8967.4 9027.9 9049.5 9054.5 9057.2 9054.5 9080.3 9083.5 9091.7 9095.3 9041.4 9070.0 9078.8 9080.5 9087.5 8978.5 9027.1 9032.4 9047.4 9051.7 43088.4 43478.8 43527.8 43582.6 43602.3 3599.6 3666.9 3786.5 3803.6 3843.0 31578.8 33608.7 33634.5 33681.5 33681.7 4345.2 4488.8 4523.9 4532.1 4562.1 388159.0 388396.0 389729.0 390042.0 390664.3 56107.0 56383.4 56542.7 56718.0 56853.7 65700.7 65793.7 65894.7 65938.7 65967.0 16292.7 16469.5 16473.3 16500.1 16537.0 12500.7 12528.1 12571.6 12578.4 12585.2 19363.5 19662.9 19752.4 19872.5 19965.6 6670.2 6955.0 6957.3 7025.7 7143.7 934.5 1047.0 1066.0 1080.6 1150.2 32889.2 32912.0 33001.0 33106.8 33751.5 1124.5 1135.0 1170.0 1194.7 1207.0 17075.7 17313.4 17318.3 17441.0 17481.5 519256.0 522778.0 523662.0 523768.0 524865.0 60729.0 60796.7 61026.0 61369.0 61423.7 1241.1 1338.6 1365.8 1382.2 1396.8 32247.5 34093.3 34182.0 34414.3 34496.8 49955.0 50494.5 50554.5 50579.0 50636.5 384320.0 384545.0 386355.0 386423.0 387058.0 24944.4 27052.6 27938.0 28592.1 28755.6 47677.3 48524.0 48593.0 49000.8 49032.0 40152.4 41097.8 41708.6 41790.4 43411.8 40921.6 41395.4 41807.5 42163.6 42234.6 35408.0 41009.4 41070.8 41565.0 41625.0 35354.6 37522.4 37950.5 37981.8 38294.0 27492.8 27725.6 27969.7 28177.0 28246.4 04:54:57 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | [#2] jquery.html Cycles:180 Average:30082.70 Median:13014.33 stddev:86446.45 (664.2%) stddev-sans-first:86660.18 04:54:57 INFO - PROCESS | 5209 | Values: 374.4 398.6 398.7 407.1 418.6 14201.3 17712.6 19728.5 19739.2 19868.1 19211.2 19306.0 19493.0 19529.4 19713.5 5483.6 5510.8 5609.4 5680.7 5710.0 5613.3 5624.4 5624.7 5651.1 5655.2 5413.2 5572.3 5607.1 5614.7 5628.7 5572.3 5598.0 5603.6 5607.9 5612.2 4870.6 4991.7 5017.0 5048.4 5048.9 23219.7 23220.7 23274.0 23444.0 23586.8 2196.3 2357.1 2441.9 2579.4 2714.4 14013.6 14156.2 14349.4 14482.4 14664.6 1819.0 1920.0 1942.5 1970.1 1976.2 78383.6 79337.6 79603.0 80080.6 82155.0 9384.6 9775.9 9991.3 10133.9 10154.5 13217.0 13234.3 13282.6 13298.5 13398.8 7664.7 7762.2 7822.0 7846.5 7954.2 7722.4 7801.4 7829.1 7943.6 8109.2 3975.8 3984.8 3991.7 3996.0 4118.1 1956.3 1961.8 1980.5 2032.2 2074.5 948.8 959.8 984.0 1044.5 1068.8 19893.4 20303.3 20314.4 20475.6 20752.2 1002.4 1005.7 1013.3 1078.8 1093.2 10484.5 11088.6 11225.9 11285.3 11334.4 512480.0 519788.0 529062.0 530081.0 530761.0 93723.5 95781.0 97365.5 98797.5 108619.0 998.2 1016.8 1053.9 1054.5 1054.8 17669.3 18094.9 18504.9 18555.0 18840.2 30340.5 31922.8 36094.1 37327.4 45735.5 57780.4 58478.4 58541.0 63855.7 65112.3 8593.7 8727.3 8839.9 8856.6 9057.8 11202.7 13362.6 13545.7 13628.9 13695.5 11211.7 11766.9 11772.1 11811.5 12263.6 10864.8 11033.8 11309.9 11456.7 11485.5 11790.4 11852.5 11992.0 12114.2 12329.2 8453.6 8626.4 8873.0 8914.0 9009.4 11225.4 11545.3 11899.8 12083.0 12088.5 04:54:57 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | [#3] mootools.html Cycles:180 Average:5651.56 Median:2581.81 stddev:3211.98 (124.4%) stddev-sans-first:3204.26 04:54:57 INFO - PROCESS | 5209 | Values: 1289.3 1437.0 1464.3 1576.4 1749.8 7952.4 8300.5 8312.1 8322.6 8474.0 8347.3 8488.4 8525.9 8527.7 8532.4 1948.0 2199.2 2269.7 2310.9 2312.2 2308.2 2334.5 2334.8 2337.2 2339.3 2265.7 2296.6 2308.0 2310.2 2310.5 1901.4 2132.8 2216.5 2219.1 2220.5 2096.5 2124.8 2126.5 2129.5 2130.2 8422.3 8504.4 8515.7 8520.4 8522.7 4897.3 4984.3 4990.6 4990.6 4998.7 3122.3 3280.8 3309.0 3317.4 3321.8 1032.4 1071.3 1089.9 1114.8 1123.2 11561.2 11765.1 11789.9 11804.5 11814.2 4374.3 4434.7 4451.2 4482.8 4569.5 10013.5 10031.1 10066.6 10070.1 10075.6 5020.0 5059.4 5062.7 5063.5 5067.4 4138.6 4549.2 4624.1 4636.5 4692.7 3889.6 3938.2 4010.7 4038.3 4066.8 1249.4 1250.1 1255.2 1269.0 1281.9 829.9 846.4 921.6 967.4 982.2 5775.7 5825.6 5848.1 5967.6 6080.7 425.9 435.6 444.9 470.9 488.4 4206.2 4242.8 4274.6 4307.2 4319.7 10336.4 10552.6 10620.1 10623.6 10629.5 9938.4 10378.7 10396.1 10589.3 10689.2 7879.7 8002.6 8046.3 8063.0 8064.2 6005.8 6069.8 6090.2 6103.0 6285.9 9905.7 9925.4 9979.5 9981.7 10023.9 9730.7 9995.0 10043.5 10138.5 10147.5 7667.1 7786.5 7862.7 7876.8 7887.0 8290.2 8312.5 8363.7 8369.0 8380.6 7289.3 7308.9 7346.1 7383.6 7587.4 7269.7 7346.9 7375.9 7434.3 7444.3 6913.4 7001.8 7012.9 7012.9 7024.1 5040.5 5210.7 5294.8 5372.9 5442.0 5279.1 5345.5 5423.0 5489.4 5558.4 04:54:57 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | [#4] prototype.html Cycles:180 Average:4509.74 Median:5109.60 stddev:1289.97 (25.2%) stddev-sans-first:1254.84 04:54:57 INFO - PROCESS | 5209 | Values: 329.1 333.2 340.9 350.3 353.0 5084.5 5213.9 5285.4 5352.0 5362.9 5165.2 5181.3 5236.2 5245.1 5274.9 4171.5 4174.4 4181.2 4181.5 4183.1 3975.9 4118.0 4175.1 4186.3 4196.8 4107.2 4111.9 4112.8 4114.7 4115.5 4081.0 4102.3 4120.7 4122.6 4123.6 3658.8 3662.0 3665.8 3675.6 3683.6 5080.6 5145.9 5149.5 5152.5 5161.5 4750.9 4767.9 4785.0 4787.1 4794.7 5441.1 5547.6 5553.5 5563.7 5566.1 3982.8 3988.3 3995.4 4002.4 4025.6 5633.9 5641.0 5649.4 5675.1 5681.0 4074.7 4077.4 4087.4 4094.3 4100.0 4029.4 4049.2 4109.9 4122.0 4136.6 4672.2 4691.3 4694.8 4695.4 4718.2 5464.8 5474.5 5501.7 5565.4 5579.0 1289.5 1339.8 1421.2 1421.5 1421.7 939.5 966.2 981.0 985.3 993.3 5194.1 5231.5 5241.8 5243.0 5266.1 5525.9 5576.9 5594.8 5600.4 5603.7 4985.6 5122.6 5208.7 5244.6 5260.2 2609.7 2627.9 2648.3 2655.9 2666.0 5103.3 5123.5 5155.8 5169.7 5179.1 4751.9 5064.0 5066.3 5079.9 5119.0 5109.6 5110.2 5114.4 5193.7 5194.0 5005.6 5040.8 5060.8 5073.4 5078.9 4815.5 4891.3 4898.2 4916.9 4929.7 5031.9 5108.8 5109.6 5116.7 5154.5 3760.8 3864.3 3934.5 4001.9 4029.1 5520.3 5600.4 5601.3 5619.0 5631.5 5448.2 5465.3 5488.6 5488.9 5526.8 5249.2 5369.3 5371.2 5389.8 5389.9 5307.7 5370.4 5380.4 5391.4 5488.8 5371.5 5459.0 5475.8 5494.7 5527.9 5275.5 5289.6 5307.3 5315.6 5343.5 04:54:57 INFO - PROCESS | 5209 | 04:54:57 INFO - PROCESS | 5209 | [#5] yui.html Cycles:180 Average:22025.76 Median:4442.37 stddev:32410.62 (729.6%) stddev-sans-first:32462.24 04:54:57 INFO - PROCESS | 5209 | Values: 768.9 770.4 800.2 833.1 846.1 15038.2 15434.5 15468.3 15469.0 15668.5 14743.7 14895.9 14897.3 14905.9 14919.9 650.7 775.2 784.1 796.8 801.6 789.4 804.2 807.6 808.4 808.6 850.5 851.8 853.3 853.4 854.6 692.2 706.0 848.4 848.9 849.6 516.6 607.3 619.7 621.3 629.0 13795.2 13813.2 13823.9 13873.9 14092.2 12935.3 12955.8 14251.4 14284.3 14309.3 12781.5 13169.2 13172.7 13199.3 13277.4 4394.3 4490.4 4496.3 4498.6 4572.5 76063.0 76123.6 76139.6 76626.6 77168.0 10403.8 10667.7 10693.0 10710.8 10747.3 21051.8 21084.3 21101.8 21108.5 21132.0 8197.4 8325.3 8514.2 8535.3 8559.7 4712.0 4998.6 5003.6 5018.1 5047.0 3388.8 3456.0 3511.1 3511.8 3515.0 579.1 583.2 589.0 597.8 612.6 641.2 668.0 679.8 714.1 724.6 9093.0 9385.3 9425.6 9518.8 9526.3 666.4 684.2 699.7 713.9 740.5 4573.3 4728.2 4853.9 4904.5 5370.9 119847.4 124662.0 124981.8 126739.4 129080.4 103403.5 105897.0 106032.0 107790.5 109776.0 94089.0 95088.0 95096.5 96783.0 97430.5 10278.9 10548.7 10591.6 10651.0 10661.4 52290.2 52349.5 53265.5 54917.2 55123.0 76575.6 82434.2 83885.2 84989.6 86963.1 13968.5 14010.3 14025.4 14429.1 14678.8 15267.6 15738.5 15910.3 15957.4 16046.5 14068.8 14398.6 14723.9 14912.9 15056.4 14302.6 14532.9 14625.9 14927.9 15075.2 12865.4 13354.9 13579.9 14042.6 14730.9 11958.6 12428.5 12440.4 12453.6 12755.0 10640.8 10886.6 11823.6 12210.8 12519.6 04:54:57 INFO - PROCESS | 5209 | -------- Summary: end -------- 04:54:57 INFO - PROCESS | 5209 | 04:54:58 INFO - TEST-INFO | 5209: exit 0 04:54:58 INFO - TEST-OK | dromaeo_css | took 1112708ms 04:54:58 INFO - TEST-START | kraken 04:54:58 INFO - operating with platform_type : linux_ 04:54:58 INFO - Initialising browser for kraken test... 04:54:58 INFO - TEST-INFO | started process 5403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvMZ2zX/profile http://localhost:46866/getInfo.html) 04:55:01 INFO - PROCESS | 5403 | __metrics Screen width/height:1600/1200 04:55:01 INFO - PROCESS | 5403 | colorDepth:24 04:55:01 INFO - PROCESS | 5403 | Browser inner width/height: 1024/697 04:55:01 INFO - PROCESS | 5403 | __metrics 04:55:02 INFO - PROCESS | 5403 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:55:02 INFO - PROCESS | 5403 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:55:02 INFO - TEST-INFO | 5403: exit 0 04:55:02 INFO - Browser initialized. 04:55:02 INFO - Running cycle 1/1 for kraken test... 04:55:02 INFO - TEST-INFO | started process 5483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvMZ2zX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:14 INFO - PROCESS | 5483 | RSS: Main: 157171712 04:55:14 INFO - PROCESS | 5483 | 04:55:17 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46866/tests/kraken/driver.html?testName=audio-beat-detection) 04:55:18 INFO - PROCESS | 5483 | RSS: Main: 213848064 04:55:18 INFO - PROCESS | 5483 | 04:55:20 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46866/tests/kraken/driver.html?testName=audio-dft) 04:55:21 INFO - PROCESS | 5483 | RSS: Main: 192462848 04:55:21 INFO - PROCESS | 5483 | 04:55:24 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46866/tests/kraken/driver.html?testName=audio-fft) 04:55:25 INFO - PROCESS | 5483 | RSS: Main: 269918208 04:55:25 INFO - PROCESS | 5483 | 04:55:27 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46866/tests/kraken/driver.html?testName=audio-oscillator) 04:55:27 INFO - PROCESS | 5483 | RSS: Main: 179896320 04:55:27 INFO - PROCESS | 5483 | 04:55:29 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:30 INFO - PROCESS | 5483 | RSS: Main: 184905728 04:55:30 INFO - PROCESS | 5483 | 04:55:33 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46866/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:34 INFO - PROCESS | 5483 | RSS: Main: 219451392 04:55:34 INFO - PROCESS | 5483 | 04:55:37 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46866/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:38 INFO - PROCESS | 5483 | RSS: Main: 220463104 04:55:38 INFO - PROCESS | 5483 | 04:55:40 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46866/tests/kraken/driver.html?testName=json-parse-financial) 04:55:41 INFO - PROCESS | 5483 | RSS: Main: 220164096 04:55:41 INFO - PROCESS | 5483 | 04:55:43 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:43 INFO - PROCESS | 5483 | RSS: Main: 184741888 04:55:43 INFO - PROCESS | 5483 | 04:55:45 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:46 INFO - PROCESS | 5483 | RSS: Main: 188993536 04:55:46 INFO - PROCESS | 5483 | 04:55:48 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:48 INFO - PROCESS | 5483 | RSS: Main: 194813952 04:55:48 INFO - PROCESS | 5483 | 04:55:51 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:51 INFO - PROCESS | 5483 | RSS: Main: 188739584 04:55:51 INFO - PROCESS | 5483 | 04:55:54 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:55 INFO - PROCESS | 5483 | RSS: Main: 193142784 04:55:55 INFO - PROCESS | 5483 | 04:55:56 INFO - PROCESS | 5483 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46866/tests/kraken/driver.html?testName=ai-astar) 04:55:57 INFO - PROCESS | 5483 | RSS: Main: 243994624 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | __start_tp_report 04:55:57 INFO - PROCESS | 5483 | _x_x_mozilla_page_load 04:55:57 INFO - PROCESS | 5483 | _x_x_mozilla_page_load_details 04:55:57 INFO - PROCESS | 5483 | |i|pagename|runs| 04:55:57 INFO - PROCESS | 5483 | |0;ai-astar;101;112;112;112;113;111;110;110;112;110 04:55:57 INFO - PROCESS | 5483 | |1;audio-beat-detection;147;120;124;182;118;121;151;116;157;117 04:55:57 INFO - PROCESS | 5483 | |2;audio-dft;161;163;163;161;161;161;160;162;161;163 04:55:57 INFO - PROCESS | 5483 | |3;audio-fft;74;77;76;113;75;75;75;75;111;75 04:55:57 INFO - PROCESS | 5483 | |4;audio-oscillator;83;83;126;83;83;84;112;83;85;120 04:55:57 INFO - PROCESS | 5483 | |5;imaging-gaussian-blur;117;116;118;117;117;117;116;116;117;117 04:55:57 INFO - PROCESS | 5483 | |6;imaging-darkroom;145;147;146;146;146;146;145;145;147;146 04:55:57 INFO - PROCESS | 5483 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;95;95 04:55:57 INFO - PROCESS | 5483 | |8;json-parse-financial;52;52;50;50;50;52;52;50;51;51 04:55:57 INFO - PROCESS | 5483 | |9;json-stringify-tinderbox;63;64;64;65;65;63;64;64;64;64 04:55:57 INFO - PROCESS | 5483 | |10;stanford-crypto-aes;75;75;82;75;76;82;75;75;75;80 04:55:57 INFO - PROCESS | 5483 | |11;stanford-crypto-ccm;121;120;120;120;127;136;123;120;189;130 04:55:57 INFO - PROCESS | 5483 | |12;stanford-crypto-pbkdf2;155;162;161;154;159;157;157;155;159;162 04:55:57 INFO - PROCESS | 5483 | |13;stanford-crypto-sha256-iterative;64;63;66;63;64;62;61;61;61;64 04:55:57 INFO - PROCESS | 5483 | __end_tp_report 04:55:57 INFO - PROCESS | 5483 | __start_cc_report 04:55:57 INFO - PROCESS | 5483 | _x_x_mozilla_cycle_collect,1674 04:55:57 INFO - PROCESS | 5483 | __end_cc_report 04:55:57 INFO - PROCESS | 5483 | __startTimestamp1469015757104__endTimestamp 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | ------- Summary: start ------- 04:55:57 INFO - PROCESS | 5483 | Number of tests: 14 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.43 (3.1%) stddev-sans-first:1.12 04:55:57 INFO - PROCESS | 5483 | Values: 101.0 112.0 112.0 112.0 113.0 111.0 110.0 110.0 112.0 110.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:135.50 stddev:22.63 (16.7%) stddev-sans-first:23.60 04:55:57 INFO - PROCESS | 5483 | Values: 147.0 120.0 124.0 182.0 118.0 121.0 151.0 116.0 157.0 117.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 04:55:57 INFO - PROCESS | 5483 | Values: 161.0 163.0 163.0 161.0 161.0 161.0 160.0 162.0 161.0 163.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:15.52 (20.7%) stddev-sans-first:16.15 04:55:57 INFO - PROCESS | 5483 | Values: 74.0 77.0 76.0 113.0 75.0 75.0 75.0 75.0 111.0 75.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:83.00 stddev:17.67 (21.3%) stddev-sans-first:18.27 04:55:57 INFO - PROCESS | 5483 | Values: 83.0 83.0 126.0 83.0 83.0 84.0 112.0 83.0 85.0 120.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 04:55:57 INFO - PROCESS | 5483 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 04:55:57 INFO - PROCESS | 5483 | Values: 145.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 147.0 146.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:55:57 INFO - PROCESS | 5483 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.50 stddev:0.94 (1.8%) stddev-sans-first:0.93 04:55:57 INFO - PROCESS | 5483 | Values: 52.0 52.0 50.0 50.0 50.0 52.0 52.0 50.0 51.0 51.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 04:55:57 INFO - PROCESS | 5483 | Values: 63.0 64.0 64.0 65.0 65.0 63.0 64.0 64.0 64.0 64.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:75.50 stddev:3.06 (4.0%) stddev-sans-first:3.15 04:55:57 INFO - PROCESS | 5483 | Values: 75.0 75.0 82.0 75.0 76.0 82.0 75.0 75.0 75.0 80.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:125.00 stddev:21.22 (17.0%) stddev-sans-first:22.22 04:55:57 INFO - PROCESS | 5483 | Values: 121.0 120.0 120.0 120.0 127.0 136.0 123.0 120.0 189.0 130.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:159.00 stddev:2.96 (1.9%) stddev-sans-first:2.92 04:55:57 INFO - PROCESS | 5483 | Values: 155.0 162.0 161.0 154.0 159.0 157.0 157.0 155.0 159.0 162.0 04:55:57 INFO - PROCESS | 5483 | 04:55:57 INFO - PROCESS | 5483 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.50 stddev:1.66 (2.6%) stddev-sans-first:1.72 04:55:57 INFO - PROCESS | 5483 | Values: 64.0 63.0 66.0 63.0 64.0 62.0 61.0 61.0 61.0 64.0 04:55:57 INFO - PROCESS | 5483 | -------- Summary: end -------- 04:55:57 INFO - PROCESS | 5483 | 04:55:58 INFO - TEST-INFO | 5483: exit 0 04:55:58 INFO - TEST-OK | kraken | took 59916ms 04:55:58 INFO - SUITE-END | took 1172s 04:55:58 INFO - Completed test suite (00:19:32) 04:55:58 INFO - javascript benchmark 04:55:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3008.7743419243557, 3042.4979878320078, 3061.800982936108, 3075.3388021575383, 3109.2382366320253, 5295.682259064449, 5319.6276260661725, 5349.251104845324, 5395.649282796616, 5453.836384908449, 5285.365756109272, 5343.305370301865, 5357.517823395893, 5409.9459005409935, 5440.782368705257, 4717.669763116592, 4765.189917713979, 4781.852355434688, 4783.6890602110925, 5035.0685123252315, 4924.70451772893, 4934.309196712463, 4974.303597496335, 4992.251162325662, 5005.224190250498, 4690.90618187636, 4803.447603525587, 4817.590504807095, 4836.395450568679, 4901.509849015088, 4736.455307639597, 4740.265258884879, 4741.905161896777, 4766.237402015696, 4853.126437241295, 4754.9341777698055, 4786.712797232142, 4805.951940480621, 4812.157872372356, 4834.395700537433, 5179.7410129493755, 5207.427183009866, 5209.1665333546825, 5231.607629427808, 5332.946670533283, 5592.161175823619, 5623.156526521014, 5633.971830140823, 5634.098544232903, 5634.408387119375, 5675.943240567624, 5676.858078548028, 5685.232493613351, 5696.3733989261145, 5699.088145896637, 5195.0, 5305.4164041955355, 5349.037173308841, 5352.892942141136, 5428.5114339708825, 5908.793192238337, 5913.142594323799, 5913.793017244376, 5919.763209471573, 5920.407959204132, 5639.464250896158, 5683.744231509592, 5686.346070201897, 5694.316681998104, 5700.486956173964, 5564.109742441271, 5638.633488823213, 5678.403767604342, 5679.716014199274, 5789.942100579025, 5695.572832037614, 5704.401037891044, 5709.286339207599, 5711.600187986801, 5711.628744131618, 5681.318241811009, 5716.256886604715, 5721.199032135504, 5735.225744524436, 5739.253896993364, 4213.136307057046, 4313.590208930209, 4348.108637729258, 4358.760268185217, 4422.049259409242, 3895.6299151580556, 3899.629535194152, 3908.843646254175, 3934.9213015740097, 3939.3106206414336, 5427.185922111715, 5434.538064264502, 5436.21174929633, 5437.564994800407, 5442.591805614595, 5522.751476183581, 5701.087825947829, 5739.995500787346, 5774.509166720792, 5836.708164591753, 5439.945600543944, 5441.646292990943, 5466.562674985991, 5476.561875050066, 5514.035043867307, 4959.504049595083, 4968.056069346812, 4968.130577149057, 4973.527514886152, 5018.172001619765, 5713.371529131792, 5749.770009199585, 5821.883562328814, 5926.762929482772, 5941.257342832146, 5643.435656434323, 5643.492085712305, 5645.491905728504, 5690.118031705092, 5706.258186435737, 5769.365369809401, 5802.332731735735, 5814.447627475383, 5819.883602328015, 5824.970875145597, 5500.752466138953, 5538.972305138448, 5545.639533430314, 5552.805651802168, 5554.08357620988, 5685.374608793112, 5705.286839145107, 5711.029125048834, 5720.656760594377, 5721.771129154788, 5590.105583106683, 5604.943950560442, 5605.887882242414, 5605.971970140124, 5611.466910643482, 5576.163575463713, 5578.330600327987, 5581.916271255853, 5583.302087239095, 5585.162225666182, 5423.3491980962535, 5527.39198688152, 5558.527525160245, 5571.13647384656, 5572.749226284908, 5483.780648774164, 5548.611597188319, 5574.024545704567, 5584.190292407659, 5588.41321661236, 5349.812756553502, 5396.271503347155, 5402.081646120248, 5403.0, 5403.621746477709], "value": 5248.973371054382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.8669292755594, 628.4124343738605, 632.8291361332438, 648.3484098481026, 654.725015493493, 43064.56935430645, 44928.3260751089, 44996.32505512416, 45001.77499112508, 47854.0, 45064.09871802562, 45583.0, 45633.771831140795, 45690.77154614231, 45702.77148614261, 9004.68483603074, 9122.498262595554, 9126.315526335518, 9151.816963660756, 9152.679656212034, 8967.41711788735, 9027.864582031274, 9049.547522623876, 9054.456732596032, 9057.184853363196, 9054.547272636375, 9080.273578113734, 9083.545822708871, 9091.681791137311, 9095.272378209727, 9041.3671043027, 9069.95465022674, 9078.818423631556, 9080.500572468512, 9087.454752714826, 8978.50618215998, 9027.097290270985, 9032.367734258605, 9047.366684332099, 9051.7284481465, 43088.3536746949, 43478.78260608709, 43527.782361088306, 43582.564174358165, 43602.345964810556, 3599.6400359963795, 3666.9190309212486, 3786.5266841644793, 3803.6386543278345, 3843.0392401899526, 31578.842105789554, 33608.663913361044, 33634.49548256778, 33681.49477757836, 33681.663183368095, 4345.174416860787, 4488.820447182109, 4523.864284071483, 4532.138893610204, 4562.110388474249, 388159.0, 388396.0, 389729.0, 390042.0, 390664.32674856245, 56107.0, 56383.43616563782, 56542.7172864133, 56718.0, 56853.71573142108, 65700.74394048465, 65793.6710316455, 65894.67052664801, 65938.67030664816, 65967.0, 16292.674146517003, 16469.505914822574, 16473.258703358377, 16500.092494912897, 16537.0, 12500.749985000431, 12528.060395470377, 12571.559995400117, 12578.433970471351, 12585.24488530691, 19363.51591210203, 19662.90168549148, 19752.40742777719, 19872.50318742043, 19965.602407831313, 6670.194813623965, 6955.0, 6957.304269573002, 7025.7353676337725, 7143.678534465961, 934.5187228577288, 1047.0, 1066.0192622787054, 1080.6271836216492, 1150.2408410449063, 32889.17777055593, 32912.0, 33001.0, 33106.834465828, 33751.493727594105, 1124.5220781168134, 1134.9943250283861, 1169.9941500292614, 1194.7252132009687, 1206.9921615451021, 17075.658486830194, 17313.3940312091, 17318.307267709402, 17440.953542787473, 17481.47555573335, 519256.0, 522778.0, 523662.0, 523768.0, 524865.0, 60729.0, 60796.69601652052, 61026.0, 61369.0, 61423.69288153531, 1241.0629974369294, 1338.6385675867461, 1365.808786769853, 1382.2328607622867, 1396.84634690184, 32247.516287256178, 34093.31813363669, 34182.0, 34414.31171376609, 34496.827515862264, 49955.0, 50494.49505505045, 50554.49445505498, 50579.0, 50636.49363506465, 384320.0, 384545.0, 386355.0, 386423.0, 387058.0, 24944.376390589656, 27052.594211087242, 27938.0, 28592.14223573296, 28755.5686664696, 47677.28484072811, 48524.0, 48593.0, 49000.754996224794, 49032.0, 40152.397714034894, 41097.794511027256, 41708.58291417168, 41790.37314440225, 43411.78294108509, 40921.59078409297, 41395.379069314586, 41807.45895877735, 42163.578364215966, 42234.5776542243, 35408.0, 41009.38485922654, 41070.79464602658, 41565.0, 41625.0, 35354.64645353617, 37522.437163442024, 37950.54901336829, 37981.810090949366, 38294.0, 27492.762825672493, 27725.584116237867, 27969.72030279671, 28177.0, 28246.43507129805], "value": 20456.950203560424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.3654505612987, 398.587461976854, 398.7308566717466, 407.08203002229965, 418.5500586869115, 14201.289935503222, 17712.645747085066, 19728.506787330323, 19739.210431582756, 19868.105935232914, 19211.231550737954, 19306.0, 19493.0, 19529.41411757646, 19713.507162320948, 5483.588730845193, 5510.752016159262, 5609.439056094398, 5680.744366503496, 5710.029295019835, 5613.298337707786, 5624.3531993820625, 5624.718764061801, 5651.124075768242, 5655.236543066695, 5413.242146099549, 5572.3034620672415, 5607.102863541834, 5614.719264036802, 5628.662280263176, 5572.275604171452, 5598.048331783607, 5603.579731520153, 5607.915881261764, 5612.186232996192, 4870.6103511718975, 4991.675541089818, 5017.0, 5048.444671086178, 5048.873778155539, 23219.651705224434, 23220.65169022466, 23274.0, 23444.0, 23586.76413235863, 2196.3191410662744, 2357.139644029934, 2441.8901149448316, 2579.445419234855, 2714.4164004739077, 14013.579592612237, 14156.221407822566, 14349.354279057468, 14482.42070317186, 14664.560063198121, 1819.0, 1919.9904000480049, 1942.5143714071482, 1970.103602860695, 1976.1502553901817, 78383.6080819598, 79337.60331198365, 79603.0, 80080.59959700222, 82155.0, 9384.57769400365, 9775.902240977499, 9991.300608957303, 10133.898661013443, 10154.492275386201, 13217.0, 13234.338283086, 13282.601521954357, 13298.468061277441, 13398.789199781926, 7664.693412263447, 7762.184970578121, 7822.0, 7846.5292082475235, 7954.164812694584, 7722.382209423233, 7801.375889928792, 7829.138794732575, 7943.602819858984, 8109.189081091961, 3975.7813320267082, 3984.8007599620482, 3991.7006224533275, 3995.980020099939, 4118.073433477443, 1956.2761778142178, 1961.7940116287584, 1980.5345743750206, 2032.2277534536781, 2074.543600407908, 948.7865230323122, 959.8128364968765, 984.0356450678232, 1044.5090807320548, 1068.759529105945, 19893.403197903797, 20303.289384871754, 20314.390568282975, 20475.59048819045, 20752.169913203303, 1002.3584905660383, 1005.6982905128432, 1013.310948554975, 1078.8381742738652, 1093.2292733622935, 10484.475776211159, 11088.5564577416, 11225.887741122484, 11285.322880627189, 11334.433278336215, 512480.0, 519788.0, 529062.0, 530081.0, 530761.0, 93723.53138234265, 95781.0, 97365.51317243368, 98797.50601246947, 108619.0, 998.1914649134225, 1016.7559785651538, 1053.878803937557, 1054.5465449856636, 1054.757405796671, 17669.293228270726, 18094.909525452287, 18504.907475462536, 18555.0, 18840.152193151065, 30340.54489182708, 31922.84038579792, 36094.09764755902, 37327.44008839815, 45735.54264457446, 57780.4221957775, 58478.415215848996, 58541.0, 63855.680721596094, 65112.34887651063, 8593.699220527502, 8727.258183054511, 8839.911600884167, 8856.601452934505, 9057.77355566116, 11202.719932001439, 13362.599122026355, 13545.729085418434, 13628.931855341056, 13695.452181913011, 11211.71970700739, 11766.882331176921, 11772.117091218022, 11811.527538898348, 12263.632091037283, 10864.837027444753, 11033.779324413626, 11309.943450282695, 11456.742812091468, 11485.540578376771, 11790.351530665552, 11852.525898963944, 11992.040636748865, 12114.21257618252, 12329.198602090835, 8453.577321134042, 8626.360991411611, 8872.955635221782, 8914.0, 9009.369344145847, 11225.438728063727, 11545.307281563133, 11899.82150267764, 12083.033357331216, 12088.456019479321], "value": 9227.82313323948, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.2973329535403, 1437.0443654969442, 1464.3190916223953, 1576.3615735627075, 1749.8075211726707, 7952.363810895129, 8300.50196988181, 8312.127226641207, 8322.583870806458, 8473.95763021184, 8347.332213422927, 8488.405811593191, 8525.91474085259, 8527.658893644262, 8532.445391049578, 1947.980520194794, 2199.2082850174006, 2269.706267427567, 2310.861348319106, 2312.2022902098747, 2308.2036697339477, 2334.48641298914, 2334.8015418689433, 2337.2170322941834, 2339.2865176121277, 2265.728112626479, 2296.6095763720123, 2307.9729520363444, 2310.2260742651233, 2310.549442858643, 1901.3915547024958, 2132.76539580646, 2216.5345277491747, 2219.123446238743, 2220.4781876259067, 2096.5073207796154, 2124.787521247863, 2126.4683829042738, 2129.4889226585665, 2130.243763463979, 8422.326213902874, 8504.447210931332, 8515.74452766418, 8520.360972927056, 8522.65909363631, 4897.314375987365, 4984.27727979441, 4990.575801056914, 4990.575801056914, 4998.7250701211415, 3122.2506598416217, 3280.78674886134, 3309.0238379678053, 3317.369699757063, 3321.8173000484962, 1032.4270030133273, 1071.2501249125564, 1089.9073578745815, 1114.7881902438592, 1123.1913022623698, 11561.248518846249, 11765.058795296442, 11789.882101178964, 11804.468798903985, 11814.232074915102, 4374.256376415953, 4434.689571730012, 4451.221036318631, 4482.843100491467, 4569.474510431343, 10013.49932503372, 10031.097201251923, 10066.597336106473, 10070.144037756872, 10075.64735234278, 5020.0, 5059.443461219263, 5062.7468626568525, 5063.518965698253, 5067.366579177603, 4138.586141385837, 4549.249373853278, 4624.075184962953, 4636.536346365404, 4692.718436893797, 3889.649931506178, 3938.1729836734607, 4010.6791456683395, 4038.3134867072667, 4066.79666016698, 1249.4127759952808, 1250.1249125612107, 1255.215490318551, 1269.0418733856063, 1281.9423125959354, 829.8921140251729, 846.4328899637258, 921.6175287255713, 967.4243824924159, 982.1933997398099, 5775.711214439261, 5825.592208545361, 5848.1227815827115, 5967.6419414835245, 6080.726367313481, 425.86372360844234, 435.5513820764618, 444.85764555342627, 470.9034647897173, 488.36024807502287, 4206.20082184384, 4242.809073591696, 4274.636655884223, 4307.203167413976, 4319.740815551014, 10336.379817210991, 10552.577896884191, 10620.097291730135, 10623.575056997788, 10629.5216715248, 9938.403695778277, 10378.688639340831, 10396.064354208158, 10589.258751887448, 10689.198310126772, 7879.684812607432, 8002.639881205243, 8046.275835174863, 8062.999999999883, 8064.153263907323, 6005.849853753691, 6069.787557435468, 6090.177825993434, 6102.9694851525455, 6285.937140628535, 9905.653302134391, 9925.3548519346, 9979.501024948579, 9981.700548983543, 10023.899761002296, 9730.659426920023, 9995.0, 10043.548040338348, 10138.49307534635, 10147.543360548645, 7667.118281397487, 7786.4938778979185, 7862.72480463181, 7876.763697089096, 7887.0, 8290.170982901904, 8312.459690120122, 8363.66545338204, 8368.958155209186, 8380.58097095155, 7289.307515785992, 7308.926910731037, 7346.118465783927, 7383.556986580822, 7587.393008559412, 7269.672864720995, 7346.889796652948, 7375.889361659687, 7434.256574342522, 7444.255574442513, 6913.3777959983845, 7001.754938577125, 7012.859742805217, 7012.894806578008, 7024.086868707035, 5040.546350828443, 5210.713410762444, 5294.788208471618, 5372.946270537401, 5442.0, 5279.102552565996, 5345.4654534546235, 5422.972885135549, 5489.39616642177, 5558.360788509373], "value": 4441.191148408647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.09827073817735, 333.1687439837604, 340.8585437043627, 350.26269702276704, 353.0467737109801, 5084.491550844914, 5213.8957220855655, 5285.392179899312, 5351.973240133799, 5362.865928351793, 5165.225216217569, 5181.3057210250645, 5236.240745091959, 5245.134552798793, 5274.92087618686, 4171.520275168349, 4174.436451079104, 4181.247375472413, 4181.540030596632, 4183.058811767359, 3975.940360894589, 4117.979410102946, 4175.102352994106, 4186.267403204442, 4196.769177695225, 4107.219628270634, 4111.917761644765, 4112.794360281989, 4114.732542384751, 4115.485564304462, 4080.9795951020205, 4102.343625020012, 4120.69241224915, 4122.587741225883, 4123.628873401408, 3658.7804731716183, 3661.963380366189, 3665.816709164531, 3675.5773086095173, 3683.631636836322, 5080.5681517070725, 5145.871353216199, 5149.45930677281, 5152.536271735525, 5161.458046905059, 4750.857474275777, 4767.904641907143, 4784.976075119602, 4787.0904528139545, 4794.736289504076, 5441.129419292894, 5547.55619550435, 5553.527950124244, 5563.693996830173, 5566.053770858964, 3982.76534274373, 3988.3219852625125, 3995.440638310639, 4002.399640054015, 4025.6175663311938, 5633.8591535211535, 5641.041023026054, 5649.350324712628, 5675.063614503602, 5680.971595141998, 4074.714769966074, 4077.4087757275624, 4087.4073259377224, 4094.28350038742, 4100.0, 4029.435878976946, 4049.190161967618, 4109.876703698894, 4122.0, 4136.5935581902295, 4672.205725026685, 4691.3432119503295, 4694.788734506956, 4695.389599352063, 4718.2214934536105, 5464.808731694372, 5474.507294343528, 5501.724913754297, 5565.443455654402, 5578.967890940189, 1289.471316760124, 1339.819124418191, 1421.1544131241894, 1421.509579195176, 1421.6730152065084, 939.5208443693765, 966.1884017425397, 981.0, 985.2561316206362, 993.3344659078434, 5194.1429664105, 5231.529162375405, 5241.816536421207, 5243.0, 5266.104762190437, 5525.917111243334, 5576.852911629052, 5594.832155035356, 5600.439956004367, 5603.719814009365, 4985.551300382983, 5122.564582010571, 5208.687478751287, 5244.580433565306, 5260.158374660113, 2609.6868375795025, 2627.868606569702, 2648.298200976743, 2655.853928033977, 2665.986670066676, 5103.260027296022, 5123.513266239701, 5155.845324640267, 5169.741512924414, 5179.067767801756, 4751.885410992076, 5064.0, 5066.316047333637, 5079.949200507947, 5119.0, 5109.616778741609, 5110.233464980282, 5114.360704911886, 5193.662411943212, 5193.974030129825, 5005.649604527648, 5040.773165207501, 5060.797568097235, 5073.351160872805, 5078.873028174326, 4815.518448155157, 4891.26631005352, 4898.24077268024, 4916.92624610624, 4929.728864912321, 5031.949680503295, 5108.8249702569365, 5109.591232701449, 5116.720819795051, 5154.458781827854, 3760.8307626157434, 3864.30442520349, 3934.4688467057726, 4001.8599349022643, 4029.1135950090934, 5520.282363292747, 5600.43995600453, 5601.327840659147, 5619.0, 5631.521320687787, 5448.237246785532, 5465.262189604353, 5488.560915126701, 5488.862778430571, 5526.806561770319, 5249.186376111708, 5369.301990741179, 5371.221172929982, 5389.8113566025, 5389.946100538945, 5307.65500242483, 5370.382406023357, 5380.354357477127, 5391.409534187345, 5488.835334939959, 5371.462853714754, 5458.972705136449, 5475.835724928259, 5494.725263736717, 5527.861803454945, 5275.525202731773, 5289.57683385336, 5307.283516725192, 5315.601329900195, 5343.530529104527], "value": 4105.409798039513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.9269519395656, 770.3721467004391, 800.2197857089335, 833.1418638802032, 846.1369403208731, 15038.248087595617, 15434.536963891087, 15468.303926323315, 15469.0, 15668.451604193855, 14743.705125897475, 14895.92552037241, 14897.329620167091, 14905.850941490582, 14919.92540037301, 650.6974256970508, 775.244136966456, 784.0982869699848, 796.7729197178805, 801.6352559585404, 789.4355535791908, 804.2078552625659, 807.5881300536739, 808.4421748993205, 808.6482380164617, 850.4982060584254, 851.7955690634234, 853.3471894001094, 853.4111463090479, 854.5513605357175, 692.2005084127841, 706.0433113131684, 848.3722045686179, 848.9405741598091, 849.570966661838, 516.6460974232625, 607.32890156377, 619.69634878909, 621.2669050520384, 629.0093103362223, 13795.241261730702, 13813.171209727449, 13823.861761382357, 13873.930630346784, 14092.224927628977, 12935.288559129243, 12955.805662915063, 14251.358688859027, 14284.285785710777, 14309.28453577317, 12781.488740450372, 13169.209847409185, 13172.736545269137, 13199.340032998312, 13277.402516886763, 4394.318880573516, 4490.416245888046, 4496.303073023654, 4498.572635599613, 4572.454211001258, 76063.0, 76123.61938190329, 76139.61930190369, 76626.61686691531, 77167.99999999943, 10403.791924161475, 10667.666541682289, 10693.0, 10710.839337409945, 10747.301425407324, 21051.78948210498, 21084.262050828147, 21101.78898211029, 21108.47228819292, 21132.0, 8197.426180167331, 8325.250727434439, 8514.233718965199, 8535.274501667303, 8559.657613695506, 4711.976440117777, 4998.5751211146735, 5003.574696150868, 5018.096742586296, 5047.041062198171, 3388.796672199676, 3455.982720086434, 3511.0871173494565, 3511.8244087795506, 3515.0333658244185, 579.0879365000058, 583.201014609987, 589.0369246282273, 597.7847974729094, 612.5712001598898, 641.2433328672118, 668.0, 679.7722762874394, 714.1323292200002, 724.6087112959049, 9093.0, 9385.296102792181, 9425.622975081056, 9518.809623807485, 9526.285528585384, 666.3503084492678, 684.1584850633649, 699.6991293743637, 713.8679344321214, 740.4853626729372, 4573.2911398732585, 4728.243481043017, 4853.9029219415415, 4904.485029071968, 5370.865728356823, 119847.40076299563, 124662.0, 124981.79750850273, 126739.36630316789, 129080.3545982264, 103403.48298258461, 105897.0, 106031.99999999846, 107790.46104769583, 109776.0, 94089.0, 95088.0, 95096.52451737697, 96783.0, 97430.51284743531, 10278.948605256926, 10548.683539493828, 10591.629292974709, 10650.97631450022, 10661.41362225054, 52290.21564676609, 52349.47650523446, 53265.46734532605, 54917.1762423556, 55123.0, 76575.61712191404, 82434.17565824265, 83885.16114838774, 84989.57505212435, 86963.1303686955, 13968.511102111377, 14010.299485025911, 14025.3688584016, 14429.134251944917, 14678.77981830252, 15267.618309542351, 15738.527844164693, 15910.284037218122, 15957.361705532114, 16046.518604441886, 14068.788968165281, 14398.640033999234, 14723.926380368459, 14912.925435372754, 15056.397744090114, 14302.57092287233, 14532.927335363256, 14625.92687036558, 14927.850721492647, 15075.19097708282, 12865.421056052688, 13354.86645133575, 13579.932100339434, 14042.648933776738, 14730.852691472948, 11958.64124076279, 12428.502859885502, 12440.409752709918, 12453.626391207916, 12755.0, 10640.787184256116, 10886.61896833607, 11823.645290641294, 12210.816837747263, 12519.624411267676], "value": 7733.433046584494, "unit": "score"}], "name": "dromaeo_css", "value": 7203.584274625861, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 112.0, 113.0, 111.0, 110.0, 110.0, 112.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 124.0, 182.0, 118.0, 121.0, 151.0, 116.0, 157.0, 117.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 113.0, 75.0, 75.0, 75.0, 75.0, 111.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 126.0, 83.0, 83.0, 84.0, 112.0, 83.0, 85.0, 120.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 50.0, 50.0, 50.0, 52.0, 52.0, 50.0, 51.0, 51.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 65.0, 63.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 82.0, 75.0, 76.0, 82.0, 75.0, 75.0, 75.0, 80.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 120.0, 120.0, 127.0, 136.0, 123.0, 120.0, 189.0, 130.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 162.0, 161.0, 154.0, 159.0, 157.0, 157.0, 155.0, 159.0, 162.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 63.0, 64.0, 62.0, 61.0, 61.0, 61.0, 64.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1485.1, "alertThreshold": 2.0}]} 04:55:58 INFO - Return code: 0 04:55:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:55:58 INFO - # TBPL SUCCESS # 04:55:58 INFO - Running post-action listener: _resource_record_post_action 04:55:58 INFO - ##### 04:55:58 INFO - ##### Finished run-tests step (success) 04:55:58 INFO - ##### 04:55:58 INFO - Running post-run listener: _resource_record_post_run 04:55:58 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559022080; Read time: 12; Write time: 424992 04:55:58 INFO - TinderboxPrint: CPU usage
13.0% 04:55:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:55:58 INFO - TinderboxPrint: I/O write bytes / time
559,022,080 / 424,992 04:55:58 INFO - TinderboxPrint: CPU idle
8,257.9 (86.9%) 04:55:58 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 04:55:58 INFO - TinderboxPrint: Swap in / out
0 / 0 04:55:58 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257552384; Read time: 0; Write time: 227384 04:55:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 301469696; Read time: 0; Write time: 197608 04:55:59 INFO - Running post-run listener: _upload_blobber_files 04:55:59 INFO - Blob upload gear active. 04:55:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:59 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:55:59 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:55:59 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:55:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:55:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:55:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:56:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:00 INFO - (blobuploader) - INFO - Done attempting. 04:56:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:56:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:56:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:01 INFO - (blobuploader) - INFO - Done attempting. 04:56:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:56:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:56:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:11 INFO - (blobuploader) - INFO - Done attempting. 04:56:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:11 INFO - Return code: 0 04:56:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48213a6288c5918ece67eae057dc743408ad3fc99cfcbee1a9b8bfa795213de80e667d31fcaa367e43e7ea59924aec28dde51c7a3a2749f79c36811f21e734dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/632b71790a3fd74f64aed77f3ebb6fc90d961b036b73d3bc87f34ae9005ecee5deb606ee847c41a75c7289ff69993288235689d11a64461d9c5140761079200e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f723d44d867c413a8739084a65f789d5003683c8dc05ac8ca2e2484fa5b502d944789925f97ef9957cdb03bfd1f2e040bcbca8ba4a1e9dd36d7f6ff10323aa6"} 04:56:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:11 INFO - Contents: 04:56:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48213a6288c5918ece67eae057dc743408ad3fc99cfcbee1a9b8bfa795213de80e667d31fcaa367e43e7ea59924aec28dde51c7a3a2749f79c36811f21e734dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/632b71790a3fd74f64aed77f3ebb6fc90d961b036b73d3bc87f34ae9005ecee5deb606ee847c41a75c7289ff69993288235689d11a64461d9c5140761079200e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f723d44d867c413a8739084a65f789d5003683c8dc05ac8ca2e2484fa5b502d944789925f97ef9957cdb03bfd1f2e040bcbca8ba4a1e9dd36d7f6ff10323aa6"} 04:56:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:11 INFO - Copying logs to upload dir... 04:56:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.147641 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-20 04:56:11.076910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 04:56:11.080758) ========= 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=0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391 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/48213a6288c5918ece67eae057dc743408ad3fc99cfcbee1a9b8bfa795213de80e667d31fcaa367e43e7ea59924aec28dde51c7a3a2749f79c36811f21e734dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/632b71790a3fd74f64aed77f3ebb6fc90d961b036b73d3bc87f34ae9005ecee5deb606ee847c41a75c7289ff69993288235689d11a64461d9c5140761079200e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f723d44d867c413a8739084a65f789d5003683c8dc05ac8ca2e2484fa5b502d944789925f97ef9957cdb03bfd1f2e040bcbca8ba4a1e9dd36d7f6ff10323aa6"} build_url:https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011503 build_url: 'https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/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/48213a6288c5918ece67eae057dc743408ad3fc99cfcbee1a9b8bfa795213de80e667d31fcaa367e43e7ea59924aec28dde51c7a3a2749f79c36811f21e734dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/632b71790a3fd74f64aed77f3ebb6fc90d961b036b73d3bc87f34ae9005ecee5deb606ee847c41a75c7289ff69993288235689d11a64461d9c5140761079200e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1f723d44d867c413a8739084a65f789d5003683c8dc05ac8ca2e2484fa5b502d944789925f97ef9957cdb03bfd1f2e040bcbca8ba4a1e9dd36d7f6ff10323aa6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 04:56:11.106451) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:56:11.106797) ========= 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=0333a256a5e4f052382dd180000001b1-1469014531.796790-236614391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:56:11.158787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 04:56:11.159094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 04:56:11.159412) ========= ========= Total master_lag: 0.13 =========