builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1467527760.95 results: success (0) buildid: 20160702144223 builduid: bd7aa9a48dd24fd185509157046c588d revision: b8b3b1c92085c1f8b74c13203289360932182da4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.951975) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.952402) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.952680) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.971514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:00.971793) ========= 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=41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:36:01-- 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% 36.9M=0s 2016-07-02 23:36:01 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:01.104953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:01.109305) ========= 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=41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019200 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:01.159132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:01.160063) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b8b3b1c92085c1f8b74c13203289360932182da4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b8b3b1c92085c1f8b74c13203289360932182da4 --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=41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:36:01,234 truncating revision to first 12 chars 2016-07-02 23:36:01,234 Setting DEBUG logging. 2016-07-02 23:36:01,234 attempt 1/10 2016-07-02 23:36:01,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b8b3b1c92085?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:36:01,672 unpacking tar archive at: autoland-b8b3b1c92085/testing/mozharness/ program finished with exit code 0 elapsedTime=0.858589 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.032487) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.032814) ========= script_repo_revision: b8b3b1c92085c1f8b74c13203289360932182da4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.033208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.033492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:36:02.042272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-02 23:36:02.042628) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:36:02 INFO - MultiFileLogger online at 20160702 23:36:02 in /builds/slave/test 23:36:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 23:36:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:36:02 INFO - {'append_to_log': False, 23:36:02 INFO - 'base_work_dir': '/builds/slave/test', 23:36:02 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 23:36:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:36:02 INFO - 'branch': 'Autoland-Non-PGO', 23:36:02 INFO - 'buildbot_json_path': 'buildprops.json', 23:36:02 INFO - 'config_files': ('talos/linux_config.py',), 23:36:02 INFO - 'default_actions': ('clobber', 23:36:02 INFO - 'read-buildbot-config', 23:36:02 INFO - 'download-and-extract', 23:36:02 INFO - 'populate-webroot', 23:36:02 INFO - 'create-virtualenv', 23:36:02 INFO - 'install', 23:36:02 INFO - 'run-tests'), 23:36:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:36:02 INFO - 'download_minidump_stackwalk': True, 23:36:02 INFO - 'download_symbols': 'ondemand', 23:36:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:36:02 INFO - 'tooltool.py': '/tools/tooltool.py', 23:36:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:36:02 INFO - '/tools/misc-python/virtualenv.py')}, 23:36:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:36:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:36:02 INFO - 'installer_path': 'installer.exe', 23:36:02 INFO - 'log_level': 'info', 23:36:02 INFO - 'log_name': 'talos', 23:36:02 INFO - 'log_to_console': True, 23:36:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:36:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:36:02 INFO - 'opt_config_files': (), 23:36:02 INFO - 'pip_index': False, 23:36:02 INFO - 'sps_profile': False, 23:36:02 INFO - 'sps_profile_interval': 0, 23:36:02 INFO - 'suite': 'dromaeojs-e10s', 23:36:02 INFO - 'system_bits': '32', 23:36:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:36:02 INFO - 'title': 'talos-linux64-ix-024', 23:36:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:36:02 INFO - 'use_talos_json': True, 23:36:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:36:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:36:02 INFO - 'work_dir': 'build'} 23:36:02 INFO - ##### 23:36:02 INFO - ##### Running clobber step. 23:36:02 INFO - ##### 23:36:02 INFO - Running pre-action listener: _resource_record_pre_action 23:36:02 INFO - Running main action method: clobber 23:36:02 INFO - rmtree: /builds/slave/test/build 23:36:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:36:02 INFO - Running post-action listener: _resource_record_post_action 23:36:02 INFO - ##### 23:36:02 INFO - ##### Finished clobber step (success) 23:36:02 INFO - ##### 23:36:02 INFO - ##### 23:36:02 INFO - ##### Running read-buildbot-config step. 23:36:02 INFO - ##### 23:36:02 INFO - Running pre-action listener: _resource_record_pre_action 23:36:02 INFO - Running main action method: read_buildbot_config 23:36:02 INFO - Using buildbot properties: 23:36:02 INFO - { 23:36:02 INFO - "project": "", 23:36:02 INFO - "product": "firefox", 23:36:02 INFO - "script_repo_revision": "production", 23:36:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 23:36:02 INFO - "repository": "", 23:36:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 23:36:02 INFO - "buildid": "20160702144223", 23:36:02 INFO - "pgo_build": "False", 23:36:02 INFO - "basedir": "/builds/slave/test", 23:36:02 INFO - "buildnumber": 31, 23:36:02 INFO - "slavename": "talos-linux64-ix-024", 23:36:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:36:02 INFO - "platform": "ubuntu64_hw", 23:36:02 INFO - "scheduler": "tests-autoland-linux64-talos", 23:36:02 INFO - "branch": "autoland", 23:36:02 INFO - "repo_path": "integration/autoland", 23:36:02 INFO - "revision": "b8b3b1c92085c1f8b74c13203289360932182da4", 23:36:02 INFO - "stage_platform": "linux64", 23:36:02 INFO - "builduid": "bd7aa9a48dd24fd185509157046c588d", 23:36:02 INFO - "slavebuilddir": "test" 23:36:02 INFO - } 23:36:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:36:02 INFO - Running post-action listener: _resource_record_post_action 23:36:02 INFO - ##### 23:36:02 INFO - ##### Finished read-buildbot-config step (success) 23:36:02 INFO - ##### 23:36:02 INFO - ##### 23:36:02 INFO - ##### Running download-and-extract step. 23:36:02 INFO - ##### 23:36:02 INFO - Running pre-action listener: _resource_record_pre_action 23:36:02 INFO - Running main action method: download_and_extract 23:36:02 INFO - mkdir: /builds/slave/test/build/tests 23:36:02 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')]} 23:36:02 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:36:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:03 INFO - Downloaded 1361 bytes. 23:36:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:36:03 INFO - Using the following test package requirements: 23:36:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:36:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:36:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:36:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:03 INFO - u'jsshell-linux-x86_64.zip'], 23:36:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:36:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:36:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:36:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:36:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:36:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:36:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23: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')]} 23:36:03 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:04 INFO - Downloaded 22705905 bytes. 23:36:04 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'] 23:36:04 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 23:36:05 INFO - Return code: 0 23:36:05 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 23:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:05 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:36:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:36:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:06 INFO - Downloaded 22705905 bytes. 23:36:06 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'] 23:36:06 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 23:36:07 INFO - Return code: 0 23: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')]} 23:36:07 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:09 INFO - Downloaded 14405327 bytes. 23:36:09 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'] 23:36:09 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 23:36:09 INFO - Return code: 0 23:36:09 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')]} 23:36:09 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:36:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:36:12 INFO - Downloaded 56486849 bytes. 23:36:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:12 INFO - mkdir: /builds/slave/test/properties 23:36:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:36:12 INFO - Writing to file /builds/slave/test/properties/build_url 23:36:12 INFO - Contents: 23:36:12 INFO - build_url:https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:36:12 INFO - Running post-action listener: _resource_record_post_action 23:36:12 INFO - Running post-action listener: set_extra_try_arguments 23:36:12 INFO - ##### 23:36:12 INFO - ##### Finished download-and-extract step (success) 23:36:12 INFO - ##### 23:36:12 INFO - ##### 23:36:12 INFO - ##### Running populate-webroot step. 23:36:12 INFO - ##### 23:36:12 INFO - Running pre-action listener: _resource_record_pre_action 23:36:12 INFO - Running main action method: populate_webroot 23:36:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:36:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:36:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:36:12 INFO - '--tppagecycles', 23:36:12 INFO - '7'], 23:36:12 INFO - 'tests': ['tsvgm']}}, 23:36:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:36:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:36:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:36:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:36:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:12 INFO - 'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:12 INFO - 'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['damp', 'tps']}, 23:36:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:12 INFO - 'tests': ['damp', 'tps']}, 23:36:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['dromaeo_dom']}, 23:36:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:36:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['basic_compositor_video']}, 23:36:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:36:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['a11yr', 23:36:12 INFO - 'ts_paint', 23:36:12 INFO - 'tpaint', 23:36:12 INFO - 'sessionrestore', 23:36:12 INFO - 'sessionrestore_no_auto_restore', 23:36:12 INFO - 'tabpaint']}, 23:36:12 INFO - 'other-e10s': {'tests': ['a11yr', 23:36:12 INFO - 'ts_paint', 23:36:12 INFO - 'tpaint', 23:36:12 INFO - 'sessionrestore', 23:36:12 INFO - 'sessionrestore_no_auto_restore', 23:36:12 INFO - 'tabpaint']}, 23:36:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:36:12 INFO - 'ts_paint', 23:36:12 INFO - 'tpaint', 23:36:12 INFO - 'sessionrestore', 23:36:12 INFO - 'sessionrestore_no_auto_restore', 23:36:12 INFO - 'tabpaint']}, 23:36:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:36:12 INFO - 'ts_paint', 23:36:12 INFO - 'tpaint', 23:36:12 INFO - 'sessionrestore', 23:36:12 INFO - 'sessionrestore_no_auto_restore', 23:36:12 INFO - 'tabpaint']}, 23:36:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['a11yr', 23:36:12 INFO - 'ts_paint', 23:36:12 INFO - 'tpaint', 23:36:12 INFO - 'sessionrestore', 23:36:12 INFO - 'sessionrestore_no_auto_restore', 23:36:12 INFO - 'tabpaint']}, 23:36:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['a11yr', 23:36:12 INFO - 'ts_paint', 23:36:12 INFO - 'tpaint', 23:36:12 INFO - 'sessionrestore', 23:36:12 INFO - 'sessionrestore_no_auto_restore', 23:36:12 INFO - 'tabpaint']}, 23:36:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['tsvgx', 23:36:12 INFO - 'tsvgr_opacity', 23:36:12 INFO - 'tart', 23:36:12 INFO - 'tscrollx', 23:36:12 INFO - 'cart']}, 23:36:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:36:12 INFO - 'tsvgr_opacity', 23:36:12 INFO - 'tart', 23:36:12 INFO - 'tscrollx', 23:36:12 INFO - 'cart']}, 23:36:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:12 INFO - 'talos_options': ['--disable-e10s'], 23:36:12 INFO - 'tests': ['tp5o']}, 23:36:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:12 INFO - 'tests': ['tp5o']}, 23:36:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:12 INFO - 'talos_options': ['--disable-e10s', 23:36:12 INFO - '--xperf_path', 23:36:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:12 INFO - 'tests': ['tp5n']}, 23:36:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:36:12 INFO - 'talos_options': ['--xperf_path', 23:36:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:12 INFO - 'tests': ['tp5n']}}, 23:36:12 INFO - 'talos.zip': {'path': '', 23:36:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:36:12 INFO - Running post-action listener: _resource_record_post_action 23:36:12 INFO - ##### 23:36:12 INFO - ##### Finished populate-webroot step (success) 23:36:12 INFO - ##### 23:36:12 INFO - ##### 23:36:12 INFO - ##### Running create-virtualenv step. 23:36:12 INFO - ##### 23:36:12 INFO - Running pre-action listener: _resource_record_pre_action 23:36:12 INFO - Running main action method: create_virtualenv 23:36:12 INFO - Creating virtualenv /builds/slave/test/build/venv 23:36:12 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 23:36:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:36:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:36:12 INFO - Using real prefix '/usr' 23:36:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:36:13 INFO - Installing distribute.............................................................................................................................................................................................done. 23:36:15 INFO - Installing pip.................done. 23:36:15 INFO - Return code: 0 23:36:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:36:15 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')]} 23:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:15 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')]} 23:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:15 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 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:15 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 23:36:15 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 23:36:15 INFO - Using env: {'DISPLAY': ':0', 23:36:15 INFO - 'HOME': '/home/cltbld', 23:36:15 INFO - 'LANG': 'en_US.UTF-8', 23:36:15 INFO - 'LANGUAGE': 'en_US:en', 23:36:15 INFO - 'LOGNAME': 'cltbld', 23:36:15 INFO - 'MAIL': '/var/mail/cltbld', 23:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:15 INFO - 'MOZ_NO_REMOTE': '1', 23:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:15 INFO - 'NO_EM_RESTART': '1', 23:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:15 INFO - 'PWD': '/builds/slave/test', 23:36:15 INFO - 'SHELL': '/bin/bash', 23:36:15 INFO - 'SHLVL': '1', 23:36:15 INFO - 'TERM': 'linux', 23:36:15 INFO - 'TMOUT': '86400', 23:36:15 INFO - 'USER': 'cltbld', 23:36:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:15 INFO - '_': '/tools/buildbot/bin/python'} 23:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:15 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 23:36:15 INFO - Cleaning up... 23:36:15 INFO - Return code: 0 23:36:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:36:15 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')]} 23:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:15 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')]} 23:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:15 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 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:15 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 23:36:15 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 23:36:15 INFO - Using env: {'DISPLAY': ':0', 23:36:15 INFO - 'HOME': '/home/cltbld', 23:36:15 INFO - 'LANG': 'en_US.UTF-8', 23:36:15 INFO - 'LANGUAGE': 'en_US:en', 23:36:15 INFO - 'LOGNAME': 'cltbld', 23:36:15 INFO - 'MAIL': '/var/mail/cltbld', 23:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:15 INFO - 'MOZ_NO_REMOTE': '1', 23:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:15 INFO - 'NO_EM_RESTART': '1', 23:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:15 INFO - 'PWD': '/builds/slave/test', 23:36:15 INFO - 'SHELL': '/bin/bash', 23:36:15 INFO - 'SHLVL': '1', 23:36:15 INFO - 'TERM': 'linux', 23:36:15 INFO - 'TMOUT': '86400', 23:36:15 INFO - 'USER': 'cltbld', 23:36:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:15 INFO - '_': '/tools/buildbot/bin/python'} 23:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:15 INFO - Downloading/unpacking psutil>=3.1.1 23:36:15 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 23:36:15 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 23:36:15 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 23:36:15 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 23:36:15 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 23:36:15 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 23:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:36:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:17 INFO - Installing collected packages: psutil 23:36:17 INFO - Running setup.py install for psutil 23:36:17 INFO - building 'psutil._psutil_linux' extension 23:36:17 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 23:36:18 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 23:36:18 INFO - building 'psutil._psutil_posix' extension 23:36:18 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 23:36:18 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 23:36:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:18 INFO - Successfully installed psutil 23:36:18 INFO - Cleaning up... 23:36:18 INFO - Return code: 0 23:36:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:36:18 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')]} 23:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:18 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')]} 23:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:18 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 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:18 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 23:36:18 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 23:36:18 INFO - Using env: {'DISPLAY': ':0', 23:36:18 INFO - 'HOME': '/home/cltbld', 23:36:18 INFO - 'LANG': 'en_US.UTF-8', 23:36:18 INFO - 'LANGUAGE': 'en_US:en', 23:36:18 INFO - 'LOGNAME': 'cltbld', 23:36:18 INFO - 'MAIL': '/var/mail/cltbld', 23:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:18 INFO - 'MOZ_NO_REMOTE': '1', 23:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:18 INFO - 'NO_EM_RESTART': '1', 23:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:18 INFO - 'PWD': '/builds/slave/test', 23:36:18 INFO - 'SHELL': '/bin/bash', 23:36:18 INFO - 'SHLVL': '1', 23:36:18 INFO - 'TERM': 'linux', 23:36:18 INFO - 'TMOUT': '86400', 23:36:18 INFO - 'USER': 'cltbld', 23:36:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:18 INFO - '_': '/tools/buildbot/bin/python'} 23:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:36:18 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 23:36:18 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 23:36:18 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 23:36:18 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 23:36:18 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 23:36:18 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 23:36:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:36:20 INFO - Installing collected packages: mozsystemmonitor 23:36:20 INFO - Running setup.py install for mozsystemmonitor 23:36:20 INFO - Successfully installed mozsystemmonitor 23:36:20 INFO - Cleaning up... 23:36:20 INFO - Return code: 0 23:36:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:20 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 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:20 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 23:36:20 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 23:36:20 INFO - Using env: {'DISPLAY': ':0', 23:36:20 INFO - 'HOME': '/home/cltbld', 23:36:20 INFO - 'LANG': 'en_US.UTF-8', 23:36:20 INFO - 'LANGUAGE': 'en_US:en', 23:36:20 INFO - 'LOGNAME': 'cltbld', 23:36:20 INFO - 'MAIL': '/var/mail/cltbld', 23:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:20 INFO - 'MOZ_NO_REMOTE': '1', 23:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:20 INFO - 'NO_EM_RESTART': '1', 23:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:20 INFO - 'PWD': '/builds/slave/test', 23:36:20 INFO - 'SHELL': '/bin/bash', 23:36:20 INFO - 'SHLVL': '1', 23:36:20 INFO - 'TERM': 'linux', 23:36:20 INFO - 'TMOUT': '86400', 23:36:20 INFO - 'USER': 'cltbld', 23:36:20 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:20 INFO - '_': '/tools/buildbot/bin/python'} 23:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:20 INFO - Downloading/unpacking jsonschema==2.5.1 23:36:20 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 23:36:20 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 23:36:20 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 23:36:20 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 23:36:20 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 23:36:20 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 23:36:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:36:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:36:22 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 23:36:22 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 23:36:22 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 23:36:22 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 23:36:22 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 23:36:22 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 23:36:23 INFO - Downloading functools32-3.2.3-2.tar.gz 23:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:36:23 INFO - warning: no files found matching '*.txt' 23:36:23 INFO - no previously-included directories found matching 'build' 23:36:23 INFO - no previously-included directories found matching 'dist' 23:36:23 INFO - no previously-included directories found matching '.git*' 23:36:23 INFO - Installing collected packages: jsonschema, functools32 23:36:23 INFO - Running setup.py install for functools32 23:36:23 INFO - warning: no files found matching '*.txt' 23:36:23 INFO - no previously-included directories found matching 'build' 23:36:23 INFO - no previously-included directories found matching 'dist' 23:36:23 INFO - no previously-included directories found matching '.git*' 23:36:23 INFO - Successfully installed jsonschema functools32 23:36:23 INFO - Cleaning up... 23:36:23 INFO - Return code: 0 23:36:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:23 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 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:23 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 23:36:23 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 23:36:23 INFO - Using env: {'DISPLAY': ':0', 23:36:23 INFO - 'HOME': '/home/cltbld', 23:36:23 INFO - 'LANG': 'en_US.UTF-8', 23:36:23 INFO - 'LANGUAGE': 'en_US:en', 23:36:23 INFO - 'LOGNAME': 'cltbld', 23:36:23 INFO - 'MAIL': '/var/mail/cltbld', 23:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:23 INFO - 'MOZ_NO_REMOTE': '1', 23:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:23 INFO - 'NO_EM_RESTART': '1', 23:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:23 INFO - 'PWD': '/builds/slave/test', 23:36:23 INFO - 'SHELL': '/bin/bash', 23:36:23 INFO - 'SHLVL': '1', 23:36:23 INFO - 'TERM': 'linux', 23:36:23 INFO - 'TMOUT': '86400', 23:36:23 INFO - 'USER': 'cltbld', 23:36:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:23 INFO - '_': '/tools/buildbot/bin/python'} 23:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:23 INFO - Downloading/unpacking blobuploader==1.2.4 23:36:23 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 23:36:23 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 23:36:23 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 23:36:23 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 23:36:23 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 23:36:23 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 23:36:26 INFO - Downloading blobuploader-1.2.4.tar.gz 23:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:36:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:36:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:26 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 23:36:27 INFO - Downloading docopt-0.6.1.tar.gz 23:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:36:27 INFO - Installing collected packages: blobuploader, requests, docopt 23:36:27 INFO - Running setup.py install for blobuploader 23:36:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:36:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:36:27 INFO - Running setup.py install for requests 23:36:27 INFO - Running setup.py install for docopt 23:36:27 INFO - Successfully installed blobuploader requests docopt 23:36:27 INFO - Cleaning up... 23:36:27 INFO - Return code: 0 23:36:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:27 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 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:27 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 23:36:27 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 23:36:27 INFO - Using env: {'DISPLAY': ':0', 23:36:27 INFO - 'HOME': '/home/cltbld', 23:36:27 INFO - 'LANG': 'en_US.UTF-8', 23:36:27 INFO - 'LANGUAGE': 'en_US:en', 23:36:27 INFO - 'LOGNAME': 'cltbld', 23:36:27 INFO - 'MAIL': '/var/mail/cltbld', 23:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:27 INFO - 'MOZ_NO_REMOTE': '1', 23:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:27 INFO - 'NO_EM_RESTART': '1', 23:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:27 INFO - 'PWD': '/builds/slave/test', 23:36:27 INFO - 'SHELL': '/bin/bash', 23:36:27 INFO - 'SHLVL': '1', 23:36:27 INFO - 'TERM': 'linux', 23:36:27 INFO - 'TMOUT': '86400', 23:36:27 INFO - 'USER': 'cltbld', 23:36:27 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:27 INFO - '_': '/tools/buildbot/bin/python'} 23:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:36:28 INFO - Running setup.py (path:/tmp/pip-m_QY7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:36:28 INFO - Running setup.py (path:/tmp/pip-6a88cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:36:28 INFO - Running setup.py (path:/tmp/pip-7hXFIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:36:28 INFO - Running setup.py (path:/tmp/pip-HKeYwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:36:28 INFO - Running setup.py (path:/tmp/pip-01FcAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:36:28 INFO - Running setup.py (path:/tmp/pip-k8HmY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:36:28 INFO - Running setup.py (path:/tmp/pip-vAxIzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:36:28 INFO - Running setup.py (path:/tmp/pip-_ycX1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:36:28 INFO - Running setup.py (path:/tmp/pip-ojohDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:36:28 INFO - Running setup.py (path:/tmp/pip-yLoxso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:36:28 INFO - Running setup.py (path:/tmp/pip-h9JkwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:36:28 INFO - Running setup.py (path:/tmp/pip-bI4_nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:36:28 INFO - Running setup.py (path:/tmp/pip-J5JPAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:36:29 INFO - Running setup.py (path:/tmp/pip-jh0AfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:29 INFO - Running setup.py (path:/tmp/pip-d0yiJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:36:29 INFO - Running setup.py (path:/tmp/pip-yF47tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:36:29 INFO - Running setup.py (path:/tmp/pip-waTxbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:36:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:36:29 INFO - Running setup.py install for manifestparser 23:36:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:36:29 INFO - Running setup.py install for mozcrash 23:36:29 INFO - Running setup.py install for mozdebug 23:36:29 INFO - Running setup.py install for mozdevice 23:36:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:36:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:36:29 INFO - Running setup.py install for mozfile 23:36:29 INFO - Running setup.py install for mozhttpd 23:36:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:36:29 INFO - Running setup.py install for mozinfo 23:36:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozInstall 23:36:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozleak 23:36:30 INFO - Running setup.py install for mozlog 23:36:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for moznetwork 23:36:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozprocess 23:36:30 INFO - Running setup.py install for mozprofile 23:36:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozrunner 23:36:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:36:30 INFO - Running setup.py install for mozscreenshot 23:36:30 INFO - Running setup.py install for moztest 23:36:30 INFO - Running setup.py install for mozversion 23:36:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:36:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:36:31 INFO - Cleaning up... 23:36:31 INFO - Return code: 0 23:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:31 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')]} 23:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:31 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')]} 23:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:31 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 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:31 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 23:36:31 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 23:36:31 INFO - Using env: {'DISPLAY': ':0', 23:36:31 INFO - 'HOME': '/home/cltbld', 23:36:31 INFO - 'LANG': 'en_US.UTF-8', 23:36:31 INFO - 'LANGUAGE': 'en_US:en', 23:36:31 INFO - 'LOGNAME': 'cltbld', 23:36:31 INFO - 'MAIL': '/var/mail/cltbld', 23:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:31 INFO - 'MOZ_NO_REMOTE': '1', 23:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:31 INFO - 'NO_EM_RESTART': '1', 23:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:31 INFO - 'PWD': '/builds/slave/test', 23:36:31 INFO - 'SHELL': '/bin/bash', 23:36:31 INFO - 'SHLVL': '1', 23:36:31 INFO - 'TERM': 'linux', 23:36:31 INFO - 'TMOUT': '86400', 23:36:31 INFO - 'USER': 'cltbld', 23:36:31 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:31 INFO - '_': '/tools/buildbot/bin/python'} 23:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:36:31 INFO - Running setup.py (path:/tmp/pip-Vw1bW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:36:31 INFO - Running setup.py (path:/tmp/pip-Q3P2LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:36:31 INFO - Running setup.py (path:/tmp/pip-qqIrVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:36:31 INFO - Running setup.py (path:/tmp/pip-twLJGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:36:31 INFO - Running setup.py (path:/tmp/pip-fSc9YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:36:31 INFO - Running setup.py (path:/tmp/pip-ZHfNYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:36:31 INFO - Running setup.py (path:/tmp/pip-VEhMok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:36:31 INFO - Running setup.py (path:/tmp/pip-YvAf5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:36:31 INFO - Running setup.py (path:/tmp/pip-bFbt7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:36:31 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)) 23:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:36:31 INFO - Running setup.py (path:/tmp/pip-V6Z9JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:36:32 INFO - Running setup.py (path:/tmp/pip-E8zYfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:36:32 INFO - Running setup.py (path:/tmp/pip-JMjjfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:36:32 INFO - Running setup.py (path:/tmp/pip-HrASH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:36:32 INFO - Running setup.py (path:/tmp/pip-suyJLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:32 INFO - Running setup.py (path:/tmp/pip-FQSHCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:36:32 INFO - Running setup.py (path:/tmp/pip-LOM1Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:36:32 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)) 23:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:36:32 INFO - Running setup.py (path:/tmp/pip-Zx3t98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:36:32 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)) 23:36:32 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)) 23:36:32 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)) 23:36:32 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)) 23:36:32 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)) 23:36:32 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)) 23:36:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:36:32 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 23:36:32 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 23:36:32 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 23:36:32 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 23:36:32 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 23:36:32 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 23:36:34 INFO - Downloading blessings-1.6.tar.gz 23:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:36:34 INFO - Installing collected packages: blessings 23:36:34 INFO - Running setup.py install for blessings 23:36:34 INFO - Successfully installed blessings 23:36:34 INFO - Cleaning up... 23:36:34 INFO - Return code: 0 23:36:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:36:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:34 INFO - Reading from file tmpfile_stdout 23:36:34 INFO - Current package versions: 23:36:34 INFO - argparse == 1.2.1 23:36:34 INFO - blessings == 1.6 23:36:34 INFO - blobuploader == 1.2.4 23:36:34 INFO - docopt == 0.6.1 23:36:34 INFO - functools32 == 3.2.3-2 23:36:34 INFO - jsonschema == 2.5.1 23:36:34 INFO - manifestparser == 1.1 23:36:34 INFO - mozInstall == 1.12 23:36:34 INFO - mozcrash == 0.17 23:36:34 INFO - mozdebug == 0.1 23:36:34 INFO - mozdevice == 0.48 23:36:34 INFO - mozfile == 1.2 23:36:34 INFO - mozhttpd == 0.7 23:36:34 INFO - mozinfo == 0.9 23:36:34 INFO - mozleak == 0.1 23:36:34 INFO - mozlog == 3.2 23:36:34 INFO - moznetwork == 0.27 23:36:34 INFO - mozprocess == 0.22 23:36:34 INFO - mozprofile == 0.28 23:36:34 INFO - mozrunner == 6.11 23:36:34 INFO - mozscreenshot == 0.1 23:36:34 INFO - mozsystemmonitor == 0.3 23:36:34 INFO - moztest == 0.7 23:36:34 INFO - mozversion == 1.4 23:36:34 INFO - psutil == 3.1.1 23:36:34 INFO - requests == 1.2.3 23:36:34 INFO - wsgiref == 0.1.2 23:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:36:34 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')]} 23:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:34 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')]} 23:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:34 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 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:34 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 23:36:34 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 23:36:34 INFO - Using env: {'DISPLAY': ':0', 23:36:34 INFO - 'HOME': '/home/cltbld', 23:36:34 INFO - 'LANG': 'en_US.UTF-8', 23:36:34 INFO - 'LANGUAGE': 'en_US:en', 23:36:34 INFO - 'LOGNAME': 'cltbld', 23:36:34 INFO - 'MAIL': '/var/mail/cltbld', 23:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:34 INFO - 'MOZ_NO_REMOTE': '1', 23:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:34 INFO - 'NO_EM_RESTART': '1', 23:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:34 INFO - 'PWD': '/builds/slave/test', 23:36:34 INFO - 'SHELL': '/bin/bash', 23:36:34 INFO - 'SHLVL': '1', 23:36:34 INFO - 'TERM': 'linux', 23:36:34 INFO - 'TMOUT': '86400', 23:36:34 INFO - 'USER': 'cltbld', 23:36:34 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:34 INFO - '_': '/tools/buildbot/bin/python'} 23:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 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)) 23:36:35 INFO - Cleaning up... 23:36:35 INFO - Return code: 0 23:36:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:36: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')]} 23:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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')]} 23:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x182d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, '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': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', '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 23:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:36:35 INFO - Using env: {'DISPLAY': ':0', 23:36:35 INFO - 'HOME': '/home/cltbld', 23:36:35 INFO - 'LANG': 'en_US.UTF-8', 23:36:35 INFO - 'LANGUAGE': 'en_US:en', 23:36:35 INFO - 'LOGNAME': 'cltbld', 23:36:35 INFO - 'MAIL': '/var/mail/cltbld', 23:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:35 INFO - 'MOZ_NO_REMOTE': '1', 23:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:35 INFO - 'NO_EM_RESTART': '1', 23:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:35 INFO - 'PWD': '/builds/slave/test', 23:36:35 INFO - 'SHELL': '/bin/bash', 23:36:35 INFO - 'SHLVL': '1', 23:36:35 INFO - 'TERM': 'linux', 23:36:35 INFO - 'TMOUT': '86400', 23:36:35 INFO - 'USER': 'cltbld', 23:36:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:35 INFO - '_': '/tools/buildbot/bin/python'} 23:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:36:35 INFO - Cleaning up... 23:36:35 INFO - Return code: 0 23:36:35 INFO - Running post-action listener: _resource_record_post_action 23:36:35 INFO - Running post-action listener: _start_resource_monitoring 23:36:35 INFO - Starting resource monitoring. 23:36:35 INFO - ##### 23:36:35 INFO - ##### Finished create-virtualenv step (success) 23:36:35 INFO - ##### 23:36:35 INFO - ##### 23:36:35 INFO - ##### Running install step. 23:36:35 INFO - ##### 23:36:35 INFO - Running pre-action listener: _resource_record_pre_action 23:36:35 INFO - Running main action method: install 23:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:36:35 INFO - Reading from file tmpfile_stdout 23:36:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:36:35 INFO - Reading from file tmpfile_stdout 23:36:35 INFO - Output received: 23:36:35 INFO - Usage: mozinstall [options] installer 23:36:35 INFO - Options: 23:36:35 INFO - -h, --help show this help message and exit 23:36:35 INFO - -d DEST, --destination=DEST 23:36:35 INFO - Directory to install application into. [default: 23:36:35 INFO - "/builds/slave/test"] 23:36:35 INFO - --app=APP Application being installed. [default: firefox] 23:36:35 INFO - mkdir: /builds/slave/test/build/application 23:36:35 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'] 23:36:35 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 23:36:51 INFO - Reading from file tmpfile_stdout 23:36:51 INFO - Output received: 23:36:51 INFO - /builds/slave/test/build/application/firefox/firefox 23:36:51 INFO - Running post-action listener: _resource_record_post_action 23:36:51 INFO - ##### 23:36:51 INFO - ##### Finished install step (success) 23:36:51 INFO - ##### 23:36:51 INFO - ##### 23:36:51 INFO - ##### Running run-tests step. 23:36:51 INFO - ##### 23:36:51 INFO - Running pre-action listener: _resource_record_pre_action 23:36:51 INFO - Running main action method: run_tests 23:36:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:36:51 INFO - Python 2.7.3 23:36:51 INFO - Return code: 0 23:36:51 INFO - grabbing minidump binary from tooltool 23:36: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')]} 23:36:51 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 0x1aeb570>, '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 0x1aec470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aec900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:36:51 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 23:36:51 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 23:36:51 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 23:36:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:36:52 INFO - Return code: 0 23:36:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:36:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:36:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:36:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:36:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:36:52 INFO - Using env: {'DISPLAY': ':0', 23:36:52 INFO - 'HOME': '/home/cltbld', 23:36:52 INFO - 'LANG': 'en_US.UTF-8', 23:36:52 INFO - 'LANGUAGE': 'en_US:en', 23:36:52 INFO - 'LOGNAME': 'cltbld', 23:36:52 INFO - 'MAIL': '/var/mail/cltbld', 23:36:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:36:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:52 INFO - 'MOZ_NO_REMOTE': '1', 23:36:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:36:52 INFO - 'NO_EM_RESTART': '1', 23:36:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:52 INFO - 'PWD': '/builds/slave/test', 23:36:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:36:52 INFO - 'SHELL': '/bin/bash', 23:36:52 INFO - 'SHLVL': '1', 23:36:52 INFO - 'TERM': 'linux', 23:36:52 INFO - 'TMOUT': '86400', 23:36:52 INFO - 'USER': 'cltbld', 23:36:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745', 23:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:52 INFO - '_': '/tools/buildbot/bin/python'} 23:36:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:36:52 INFO - mozversion application_buildid: 20160702144223 23:36:52 INFO - mozversion application_changeset: b8b3b1c92085c1f8b74c13203289360932182da4 23:36:52 INFO - mozversion application_display_name: Nightly 23:36:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:36:52 INFO - mozversion application_name: Firefox 23:36:52 INFO - mozversion application_remotingname: firefox 23:36:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:36:52 INFO - mozversion application_vendor: Mozilla 23:36:52 INFO - mozversion application_version: 50.0a1 23:36:52 INFO - mozversion platform_buildid: 20160702144223 23:36:52 INFO - mozversion platform_changeset: b8b3b1c92085c1f8b74c13203289360932182da4 23:36:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:36:52 INFO - mozversion platform_version: 50.0a1 23:36:52 INFO - using testdate: 1467527812 23:36:52 INFO - actual date: 1467527812 23:36:52 INFO - starting webserver on 'localhost:42996' 23:36:52 INFO - SUITE-START | Running 2 tests 23:36:52 INFO - TEST-START | dromaeo_css 23:36:52 INFO - operating with platform_type : linux_ 23:36:52 INFO - Initialising browser for dromaeo_css test... 23:36:52 INFO - TEST-INFO | started process 5566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXzKrKi/profile http://localhost:42996/getInfo.html) 23:36:57 INFO - PROCESS | 5566 | __metrics Screen width/height:1600/1200 23:36:57 INFO - PROCESS | 5566 | colorDepth:24 23:36:57 INFO - PROCESS | 5566 | Browser inner width/height: 1024/697 23:36:57 INFO - PROCESS | 5566 | __metrics 23:36:57 ERROR - PROCESS | 5566 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 23:36:58 INFO - TEST-INFO | 5566: exit 0 23:36:58 INFO - Browser initialized. 23:36:58 INFO - Running cycle 1/1 for dromaeo_css test... 23:36:58 INFO - TEST-INFO | started process 5686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXzKrKi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:37:10 INFO - PROCESS | 5686 | RSS: Main: 168968192 23:37:10 INFO - PROCESS | 5686 | 23:38:00 INFO - PROCESS | 5686 | 1467527880348 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] 23:40:12 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42996/tests/dromaeo/cssquery-ext.html) 23:40:13 INFO - PROCESS | 5686 | RSS: Main: 168747008 23:40:13 INFO - PROCESS | 5686 | 23:43:15 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-ext.html (next: http://localhost:42996/tests/dromaeo/cssquery-jquery.html) 23:43:16 INFO - PROCESS | 5686 | RSS: Main: 168599552 23:43:16 INFO - PROCESS | 5686 | 23:46:18 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42996/tests/dromaeo/cssquery-mootools.html) 23:46:18 INFO - PROCESS | 5686 | RSS: Main: 171225088 23:46:18 INFO - PROCESS | 5686 | 23:49:20 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42996/tests/dromaeo/cssquery-prototype.html) 23:49:21 INFO - PROCESS | 5686 | RSS: Main: 166989824 23:49:21 INFO - PROCESS | 5686 | 23:52:24 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42996/tests/dromaeo/cssquery-yui.html) 23:52:24 INFO - PROCESS | 5686 | RSS: Main: 169013248 23:52:24 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | Cycle 1(1): loaded http://localhost:42996/tests/dromaeo/cssquery-yui.html (next: http://localhost:42996/tests/dromaeo/cssquery-dojo.html) 23:55:27 INFO - PROCESS | 5686 | RSS: Main: 169848832 23:55:27 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | __start_tp_report 23:55:27 INFO - PROCESS | 5686 | _x_x_mozilla_page_load 23:55:27 INFO - PROCESS | 5686 | _x_x_mozilla_page_load_details 23:55:27 INFO - PROCESS | 5686 | |i|pagename|runs| 23:55:27 INFO - PROCESS | 5686 | |0;dojo.html;2632.631431599576;2682.81220314578;2698.392861606139;2698.4198397344567;2699.959500607491;4746.596539294155;4788.664793464459;4824.565789078983;4832.106060378833;4869.513048695128;4707.4586422561415;4756.7621618919;4777.498362671913;4789.257665061921;4837.250226214934;4412.095520418315;4437.156940181371;4468.776561171929;4497.617702495292;4533.002739397344;4423.977880110611;4445.711028783118;4447.266201076818;4581.450225972888;4584.4498660160825;4490.775461226942;4498.325251212312;4500.347449619803;4516.774161291939;4539.024109816389;171.29629235475366;4404.977975110136;4508.436445444319;4508.504064552896;4531.048479819242;4377.277749171383;4383.408239887638;4390.187815254157;4402.581754733327;4443.355713421568;4706.152892479352;4759.714417134948;4784.40194975628;4796.280557916306;4798.784054717511;5012.799488020475;5054.469280725544;5095.464976177485;5123.564497017758;5129.615278854101;5122.974385128088;5127.051495473349;5194.896102077937;5212.139996900507;5259.0270799901755;4780.043991201704;4814.037192561502;4828.372311599504;4833.637477189225;4835.1296766581645;5254.789808407697;5288.206768984683;5296.708681022504;5298.178782288752;5344.518993290545;5033.169527028;5073.188289873602;5077.035363280965;5080.364954380702;5084.618653600995;5121.564667003272;5132.358455193101;5160.845174644766;5163.40620828602;5174.172132458789;5089.923651145235;5109.565686916654;5112.130937740519;5119.155339368963;5162.948370516322;5105.744712764421;5117.406967577154;5119.795208191705;5128.333316668809;5163.741812909339;4205.894852628648;4282.678799090018;4299.269124248885;4320.179165958458;4335.978320108379;3737.831797569116;3740;3749.4938183345444;3766.3408903442337;3793.146542028077;4470.776461176928;4482.125985432875;4501.864944051684;4513.413256276663;4538.387317712132;5049.545540901337;5145.45972672864;5175.783690832652;5213.035588416155;5264.92102618461;4544.7045942013665;4546.681732278775;4549.226631472658;4549.658775591844;4591.609713174351;4633.72197668141;4674.322223277606;4679.3916790816975;4686.39076920005;4715.999999999932;4743.288506724019;4796.424429068465;4813.4945830687275;4871.48849370811;4876.951455437098;5141.0232055909255;5175.870603234949;5192.818251361185;5193.792248310026;5209.453007434165;4862.854114376574;4871.683340582851;4878.024395120919;4881.707097574157;4943.925841112458;4995.975020124876;5028.924566131438;5065.645404821627;5074.3657042869645;5087.771050302671;5150.896982060262;5162.97418512905;5164.1995490699;5164.9741751291;5209.609279303992;4919.1883339248625;5018.598512119095;5018.799248030038;5020.42265139499;5024.346834911438;4972.925406118983;4992.850214493571;5031.7484125792835;5036.647434679538;5067.315912351785;4937.950620493749;5006;5018.1218286800395;5026.4973502649445;5088.0587091388215;4991.775370108281;5022.045811295842;5109.20807274873;5117.334746482933;5135.998480296306;4882.584980276574;4984.327115839315;4985.6510044298;5009.499050095107;5024.57291130258 23:55:27 INFO - PROCESS | 5686 | |1;ext.html;563.3380777586335;572.4189947203588;581.4679568195102;586.5337057039653;618.5700937848192;35385;40006.199876002465;40047;40092.799536002276;40193;29865.402691946147;30323.84838075812;30420.391592168144;30634.23414414635;31372;7838.804029899241;7943.64253608589;7984.24149705777;7986.480878742892;8008.03903531577;7894.17111203324;7921.405894557903;7983;8016.318612917879;8017;8039.236272554127;8059.355251579889;8060.879086813702;8062.07286162093;8092.595370231465;7968.482048666847;7996.120426753053;8004.719244920785;8020.278174964281;8041;7931.881021784678;7933.206679332078;7986.920130798734;7996.4002699797165;8011.559364234965;38860.61139388626;38917.80541097277;39107.60892391068;39183.21633567341;39262.21475570473;3166.9208269793207;3282.195862013822;3312.5362449257123;3320.0371892151247;3387.170143314879;29906.55140172899;30437.847810760806;30690.846545767352;30791.230219244473;31398.843005785053;3454.8618055277757;3481.860725570974;3523.312953973976;3525.330187264437;3584.6953008994265;263151;263380;265093;265297;267351;32413.675863241537;53491.465085349424;53860.461395385544;53865.73067134639;53937.1909421359;32083.839580802414;34570.82714586411;34652.82673586616;34665;34721.30557388838;13276.73446531064;13528.729425411437;13546.254955977516;13569.796453053212;13570.59288221355;10920.29018113836;10951.397673127894;10971.286866353661;11045.33727976324;11093.168012399103;8092.271695547429;8101.918980810235;8123.228293312126;8155.755327340189;8179.591020448954;3158.1630867820045;3161.7470602351755;3196.1689960609942;3200.0559834848777;3217.501287300472;902.3548163063441;954.1984732824461;966.5553845231132;979.7550612346913;1016.5679586175846;28561.28596785097;28941.710582894324;29206.123816285544;29668.554971675443;29724.256893577833;937.4515908193647;995.9253056020827;1026.5226669598671;1061.1828891753307;1062.9574817007233;14570.708585828224;14918;14996.175210363535;15104.471343502924;15367.61580960485;408667;413549;415142;415907;416829;49815.75092124516;50315.74842125766;50357.49642503528;50409.747951260746;50668.239976400386;1171.3323405658864;1174.2112482853224;1177.0465922602718;1187.0088476122362;1199.748052908899;27101;28117.297067572657;28286.71713282841;28699.42601148007;30290.545641815832;47719.28421073617;47937;48409.27386089141;48461;48470.5152948466;286127;286819;287382;289006;289471;38397.808010959765;39691.20617587574;39936;40434.595654043085;40684.38973415342;43048.56951430446;43772.34341484817;43785.343219852366;44113.77943110264;44349;37964.2407151861;38237;38863.41704874373;39061.21877562376;39087.60912390953;37851.810740946115;38176.809115954245;38540.22919541538;38760.80619596884;39195.43218271237;36725.81637091797;37390.626093739804;37823.43264851085;37848.43227351647;38197.236055279296;33131.337373252885;36264.456033159;37736.62263377441;37759;38166.618333817416;26035.349116272246;26039.609405858548;26163;26427.207183784518;26549.203523894314 23:55:27 INFO - PROCESS | 5686 | |2;jquery.html;362.84216365880843;372.8508596561376;377.5978582809308;381.4849952564037;383.8925100971729;16204.594885127877;17501;18212.634052446087;18415.539611509717;18607.813921860776;17038.74441883373;17162.31350745972;17376.304947802073;17738;17778.733319000192;5120.564751996076;5243.528082472577;5275.709835959021;5282;5297.44376840432;3630;5181.300524429211;5872.7944521941745;6213.968930155343;6218.253809542861;6059.484943779784;6117.5717699761035;6122.602030868002;6139.8772024559485;6169.413905678954;5945.910811337833;6080.331163572004;6103.969480152615;6108.267007959051;6110.541709371792;5252.395974462909;5264.236685680593;5264.842054738364;5270.841874743764;5335.093034184198;20753.377398678065;21175.68236476454;21366.465838354165;21710.240141594968;21714.13143474259;1970;2055.075216152722;2108.9261875834272;2125.6811478278228;2576.9563326852654;13751.587452376445;14097.154170749787;14176.858231417656;14210.502632407815;14342.49801256951;1770.9645807083914;1829.0397541290795;1835.183343412182;1860.7860096088987;1876.8686191966567;72320.63839680768;73212.63393682998;73246.63376683083;76793;80574.19425805725;9543.665971690958;9712.028797120372;9947.751306217402;10110.313377804569;10498.265121441578;14037.859621403859;14053.297335133408;14118.294085295694;14137.646558836112;14235.003549751626;6760.526763126534;6887.827804304932;7027;7102.4318054555515;7110.608916509642;6469.126667899867;6471.47345872365;6505.772297969548;6615.569987950767;6629.370209830058;4028.91942161161;4044.2518134145275;4157.875263742032;4196.223698615705;4542.159700455426;1673.5230459319037;1676.597616572014;1713.2461716844548;1857.600615867568;1900.1829213438355;769.2999370572752;839.8362319347668;908.7182973278304;916.1800188830958;917.1607978699416;16629.91685041567;17137.314507419815;17252.309907603805;17752.822471775376;18076;887.5606574745542;890.2610833008588;895.5387975192781;947.4552132523827;962.6486332488591;9642.373245739005;9648.807023859483;9783.266255030901;9884.851727224097;10040.397576145455;453946;463283;464888;467137;467202;62674.37325626777;84094.79526023674;87521.5623921889;87826.56086719525;88550;877.4691311756424;883.6774577279247;888.4757992784417;893.8525143351404;896.050186801992;15262.23688815577;15670.843291567395;15688.92155539215;15795.131267780382;15841.52475425739;36481.270374591826;38923.2215355697;39966;40258.1948361037;40276.597234027286;54030.729846350514;55625;55679.443205567426;56149.43850561605;56840.14739778989;7408.518446300973;7466.477346585687;7468.402527797872;7576.545407275581;7582.810429739301;9045.909540904508;11190.104791616814;12039.518419263131;12116.21244619097;12207.45066471993;10756.784864302826;10803.891961080602;10849.728756781144;11122.388268645302;11226;7703.845923081395;10534.789304214026;10633.415162166155;10706.89293107059;10803.621873234399;10432.165426765992;10621.415822129857;10827.837582436112;10999.450027498433;11219.102471802073;7676.232376762279;7701.576413297323;7817.726379576688;7845.5684937329;8155.83688326242;9660.613575456902;10737.248392612755;10985.340879547253;11000.889991099986;11200.943995279971 23:55:27 INFO - PROCESS | 5686 | |3;mootools.html;1369.9794503082455;1397.8322601287844;1476.2028504607513;1701.7617533545313;1705.1985566783608;7245.203027666952;7644.235576442353;7791.766247012584;8155.062167850699;8162.14297498763;7917.049954005513;8078.838423231547;8113.269805717484;8179.222973817493;8213.26080652741;2196.3301193136085;2254.9436264093447;2269.706267427567;2271.1483193802324;2274.931752047441;2198.164697414988;2226.955460890781;2238.541099074686;2246.8988895499742;2262.468319944812;2173.880436575988;2232.687423760675;2242.831787615927;2250.2124256510174;2255.22194842779;2101.3485819395883;2111.7043613894066;2112.028466905233;2114.6722258050027;2128.446603882986;2148.516583768655;2149.57008598281;2151.709519214902;2151.8386121040985;2156.698062271283;8102.7569172924905;8110.837783244302;8168.509889406655;8190.180981901822;8226.629801658939;4626.953730462719;4656.790444429975;4713.410823647044;4717.2452407614965;4729.9763501182615;2940.2502361897577;3016.547517872315;3087.4751292280366;3091.2580980564726;3095.2107212660626;991.3952488981715;993.438707130469;1009.8434742614907;1011.5094179323022;1025.374521541859;11235.887641123647;11242.269252498561;11298;11367.317960922372;11373.374464404455;4099.241640296555;4253.404523366731;4337.652987760972;4344.174606824757;4347.956520434818;8785.033646298902;8886;8900.465972041698;8915.910840891638;8932.017478077407;4714.787834547385;4744.430668319755;4761.071591039783;4766.142094423037;4772.737499437564;3645.6354364563863;4280.101178752435;4397.9560204398185;4398.186335527937;4406.911861762811;3602.7117830574016;3644.21649345392;3676.963230367662;3703.2593481303848;3747.6508456955476;1042.5360714482135;1055.894410558938;1086.9782604347868;1092.830611255241;1129.3901293301526;841.1000229754104;844.4511067805976;850.8000619854329;865.2558799432483;875.5053394831899;5235.58115350771;5314.1497360422145;5438.157085651651;5476.67139971603;5496.148097044965;847.1570787066785;850.9405789791625;854.3933806996978;862.4523427623504;863.4301361101643;3650.580183278904;3668.981655091761;3697.9815100924325;3727.329080765434;3815;9982.201423886072;10396;10468.214883883738;10487.37075775456;10490.947545262225;10171.389716617026;10259.948700256451;10283.742906427398;10303.124234440156;10348.120409765104;7683.346915512132;7734.1492435832015;7757.4181936355;7786.57173855432;7831.412644051605;5201.479852014768;5332.33345831771;5346.4228052723765;5447.700376479332;5447.836564902901;9386.249100072115;9394.577244023898;9440.622375104918;9588.232941364813;9686.854697179408;9439.197668198005;9653.227741780782;9667.9033209667;9763.463009534544;9855.21158307348;6035.275766907999;6524.2823289439075;6660.500462465431;6769.796906092825;6946.826329341807;7987.361011119213;8049.718259860877;8065.637046332812;8081.595920203848;8141.3893957952205;6937.202221744362;7311;7365.447591430771;7413.703451862081;7418.925810742039;6696.497762667722;6878.27778083294;7118.181409138016;7169.641517924188;7276.745313913988;6694.698738556874;6753.3921947025;6755.392014718699;6763.966180169265;6796.490263230178;4679.181143299841;4760.857174284777;4776.761161941819;4784.521547845187;4825.445073816416;4719.3628860103445;4765.142274390504;4776.140294746979;4783.995360974234;4827.61379089679 23:55:27 INFO - PROCESS | 5686 | |4;prototype.html;303.0877060049252;307.9045495896272;310.39008348595013;315.73951490020727;318.2965645922514;4944.5055494450535;5052.722100284483;5127.615428842838;5209.114450543408;5224.503672151149;5078.5175408336245;5119.928043174094;5125.538701516863;5126.307948426961;5150.974245128769;4043.716939814214;4044.231595996766;4044.352903535435;4053.898652533681;4062.329715596923;3910.863119790808;4012.3379642358977;4041.1917616476676;4053.513578370585;4065.369867670501;3943.940840887389;3963.2271707017;3980.646580162744;3985.8007099645047;4008.9198216035807;3957.3074711925588;3987.5613682494904;4010.2380547696134;4011.2178125265586;4022.597740225983;3547.7516573839844;3562.8931132066077;3565.732570057256;3569.714422846166;3571.017970058255;4810.326554282403;4985;4992.176290911995;4997.800087996476;5056.317397151374;4583.335416364608;4589.426321709786;4591.977040114778;4601.585857272861;4619.006913513577;5371.328583927009;5388.568914486832;5394.626364399652;5407.134858422673;5414.620976531644;3532.9646703532894;3698.981505092457;3704.37025705628;3706.499622550948;3890.727649064567;5554.333479982388;5563.554915606742;5593.552515798767;5594.384617692051;5595.552355811566;3847.5960024197057;3848.5381754189675;3852.3451013327804;3859.4017927221325;3866.7293289469467;3665.395209790355;3843.36584463566;3901.6098390160755;3917.3144699678014;3919.9216015679526;4414.933775993362;4430.13612345596;4439.955600444019;4442.333649952533;4445.755483448376;5313.123334649817;5331.280277162611;5342.545883599938;5384.0847056000575;5394.08300588893;1253.3921048291572;1319.2348437905991;1329.2157627000117;1343.2343564168525;1347.2724728646617;894.1639567004871;901.9954900225457;916.7708072981754;918.4581097152578;928.79102202004;4658.552671023486;4668.346431499593;4672.906541869143;4672.929906051412;4678.204705200124;5410.83767486976;5422.6475279106735;5424.62027658068;5443.537299329522;5471.5896307777075;4527.818887244473;4680.063987202573;4684;4684.391029166255;4701.553352431513;2933.2080338308538;2934.105097945147;2939.0448104366164;2945;2951.3064429858964;5157.277981082651;5204.583633309327;5222.5376894468845;5226.712530810766;5264.6051546134195;5490.615656903979;5631.605787594829;5642.7178641067785;5644.887102258014;5659.660420374791;5183.196604526304;5189.391288700515;5200.609954253446;5216.295800067019;5232.9738351308;5493.450654934634;5495.477929596682;5553.6390134641115;5561;5568.443155684399;5265.578753699771;5409.107497263065;5411.567074633941;5420.810271640474;5426.972865135649;5165.793368265227;5183.896322073462;5192.402873669425;5224;5225.869353266199;3806.8477260909253;3809.8857034287907;3838.9040273993373;3844.2119365530557;3862.594427585063;5227.92158117621;5369.19462080691;5499.587530935116;5531.7234138292115;5547;5188.7405629719115;5395.838124856261;5398.1902714593125;5401.8919621606565;5414.7021913795115;5308.442613525679;5330.148370621699;5369.382521009978;5371.221172929982;5373.301470808769;5119.590432765444;5254.6847189168775;5255.106631872667;5262.9210561842365;5276.5251127398715;5332.22682710997;5376;5389.568834493152;5402.891942161214;5407.459254074561;5254.816081437131;5257.947420525746;5260.473952604709;5275.180062878301;5316.388615309289 23:55:27 INFO - PROCESS | 5686 | |5;yui.html;629.9622022678639;648.7242921758254;654.4012228810639;659.4807834073838;753.6495529578748;13653.931730341346;13962.301884905764;14468.131912085282;14520;14555.617216364455;13760.036797424184;13768.105073170236;13791.379387927542;13882.79175812361;13992.790108148385;619.0590302739855;752.586077657289;767.1024900865987;776.2780614028951;786.0645831460572;779.5712358202994;785.956772377519;786.3905473258242;788.286600626434;790.9920900791004;821.5604651511443;823.1357075071181;824.1634740738156;829.0548774397192;831.9500829950192;818.6520728690283;823.5758584329076;824.3652387661527;824.7938015496126;828.0725587342155;600.5975996082635;600.8197540737805;601.3445344574435;601.3986013986014;602.8071017274474;13416.329183540882;13478.730425391437;13482.12366196204;13499.932500337436;13547.932260338635;13771.173729576258;14119.505817296447;14148.787768183383;14201.727723564283;14422.639434014129;10657.360558366445;10833.945830270877;11101.72245693856;11181.776364472666;11182.32906025633;3354.748393870445;3417.5557177567007;3429.228423604694;3492.2142517933517;3493;57122.42877571254;62174.689126554076;62356.376436235965;62507.06239406412;62829.68585157045;11144.387058711687;11173.441327933571;11181.608643697595;11214.439278036229;11383.260088094248;20110.195592176442;20184;20212.494687632927;20278.49303767388;20429.897850510653;7080.716771329192;7106.71573137079;7130.465215108888;7212.891806622905;7349.191588925214;3700.1119731264303;3825.6365645264214;3838.1747924195874;3867.7485963412287;3886.941695874564;2839.6024556562097;2950.8524573771224;2956.51217549102;2959.3785305085744;3276.836158192081;546.7075114813636;556.4630131922714;569.8205065404385;582.1500609110661;591.7662523303358;487.61478432039;547.6686604604237;563.7378618942212;598.5211830535554;601.59392410123;8554.91445085541;8612.78468038304;8695.869511969608;8769.824603508021;8861.73414797557;531.2801154435762;591.4056373344761;604.5858586867921;612.8804883047762;619.5105866365611;4161.854335098257;4168.782420821031;4194.387623378954;4194.601512856274;4209.936850947238;101946.98053019374;103920;104538.36462895201;105194;105579;69843.65078174678;93121.53439232761;93449.79475923463;93547.53226233962;93858.53070734603;75789.62105189549;76796.23203768002;77952.99999999886;80551.59724201342;80738;7926.762197134095;7983.281504664608;7993.600319984093;8043.6782528698195;8148.307393871587;46052.7697361511;47596.7620161897;49122.75438622784;49445.752771235915;50511.24233136579;46622;68457;68995.65502172457;70145;70983.64508177426;10112.949435252776;10236.129928955825;10370.27408081427;10550.472476375997;10590.4704764763;10675.412852293199;10892.891071089187;10912.672619821418;10942.288751231144;11005.449727513753;10910.345379277269;10976.560937562408;11138.438159223262;11302.773944521228;11333.32000079965;9635.614575416905;9658.7585310365;9813.656522021694;9929.453880036668;9963.202943764336;10619.203559732896;10915.181361397768;11072.280301780358;11252.887471125185;11319.717007074889;9473.100055494717;9526.47604381738;9535.570899309409;9759.80480390374;9871.753206169904;9283.39657922233;9657.372270802376;9660.95169524176;9673.70978870635;9743.756406089904 23:55:27 INFO - PROCESS | 5686 | __end_tp_report 23:55:27 INFO - PROCESS | 5686 | __start_cc_report 23:55:27 INFO - PROCESS | 5686 | _x_x_mozilla_cycle_collect,372 23:55:27 INFO - PROCESS | 5686 | __end_cc_report 23:55:27 INFO - PROCESS | 5686 | __startTimestamp1467528927554__endTimestamp 23:55:27 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | ------- Summary: start ------- 23:55:27 INFO - PROCESS | 5686 | Number of tests: 6 23:55:27 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | [#0] dojo.html Cycles:165 Average:4743.51 Median:4878.02 stddev:613.89 (12.6%) stddev-sans-first:593.02 23:55:27 INFO - PROCESS | 5686 | Values: 2632.6 2682.8 2698.4 2698.4 2700.0 4746.6 4788.7 4824.6 4832.1 4869.5 4707.5 4756.8 4777.5 4789.3 4837.3 4412.1 4437.2 4468.8 4497.6 4533.0 4424.0 4445.7 4447.3 4581.5 4584.4 4490.8 4498.3 4500.3 4516.8 4539.0 171.3 4405.0 4508.4 4508.5 4531.0 4377.3 4383.4 4390.2 4402.6 4443.4 4706.2 4759.7 4784.4 4796.3 4798.8 5012.8 5054.5 5095.5 5123.6 5129.6 5123.0 5127.1 5194.9 5212.1 5259.0 4780.0 4814.0 4828.4 4833.6 4835.1 5254.8 5288.2 5296.7 5298.2 5344.5 5033.2 5073.2 5077.0 5080.4 5084.6 5121.6 5132.4 5160.8 5163.4 5174.2 5089.9 5109.6 5112.1 5119.2 5162.9 5105.7 5117.4 5119.8 5128.3 5163.7 4205.9 4282.7 4299.3 4320.2 4336.0 3737.8 3740.0 3749.5 3766.3 3793.1 4470.8 4482.1 4501.9 4513.4 4538.4 5049.5 5145.5 5175.8 5213.0 5264.9 4544.7 4546.7 4549.2 4549.7 4591.6 4633.7 4674.3 4679.4 4686.4 4716.0 4743.3 4796.4 4813.5 4871.5 4877.0 5141.0 5175.9 5192.8 5193.8 5209.5 4862.9 4871.7 4878.0 4881.7 4943.9 4996.0 5028.9 5065.6 5074.4 5087.8 5150.9 5163.0 5164.2 5165.0 5209.6 4919.2 5018.6 5018.8 5020.4 5024.3 4972.9 4992.9 5031.7 5036.6 5067.3 4938.0 5006.0 5018.1 5026.5 5088.1 4991.8 5022.0 5109.2 5117.3 5136.0 4882.6 4984.3 4985.7 5009.5 5024.6 23:55:27 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | [#1] ext.html Cycles:180 Average:47457.16 Median:38065.43 stddev:86735.68 (227.9%) stddev-sans-first:86907.53 23:55:27 INFO - PROCESS | 5686 | Values: 563.3 572.4 581.5 586.5 618.6 35385.0 40006.2 40047.0 40092.8 40193.0 29865.4 30323.8 30420.4 30634.2 31372.0 7838.8 7943.6 7984.2 7986.5 8008.0 7894.2 7921.4 7983.0 8016.3 8017.0 8039.2 8059.4 8060.9 8062.1 8092.6 7968.5 7996.1 8004.7 8020.3 8041.0 7931.9 7933.2 7986.9 7996.4 8011.6 38860.6 38917.8 39107.6 39183.2 39262.2 3166.9 3282.2 3312.5 3320.0 3387.2 29906.6 30437.8 30690.8 30791.2 31398.8 3454.9 3481.9 3523.3 3525.3 3584.7 263151.0 263380.0 265093.0 265297.0 267351.0 32413.7 53491.5 53860.5 53865.7 53937.2 32083.8 34570.8 34652.8 34665.0 34721.3 13276.7 13528.7 13546.3 13569.8 13570.6 10920.3 10951.4 10971.3 11045.3 11093.2 8092.3 8101.9 8123.2 8155.8 8179.6 3158.2 3161.7 3196.2 3200.1 3217.5 902.4 954.2 966.6 979.8 1016.6 28561.3 28941.7 29206.1 29668.6 29724.3 937.5 995.9 1026.5 1061.2 1063.0 14570.7 14918.0 14996.2 15104.5 15367.6 408667.0 413549.0 415142.0 415907.0 416829.0 49815.8 50315.7 50357.5 50409.7 50668.2 1171.3 1174.2 1177.0 1187.0 1199.7 27101.0 28117.3 28286.7 28699.4 30290.5 47719.3 47937.0 48409.3 48461.0 48470.5 286127.0 286819.0 287382.0 289006.0 289471.0 38397.8 39691.2 39936.0 40434.6 40684.4 43048.6 43772.3 43785.3 44113.8 44349.0 37964.2 38237.0 38863.4 39061.2 39087.6 37851.8 38176.8 38540.2 38760.8 39195.4 36725.8 37390.6 37823.4 37848.4 38197.2 33131.3 36264.5 37736.6 37759.0 38166.6 26035.3 26039.6 26163.0 26427.2 26549.2 23:55:27 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | [#2] jquery.html Cycles:180 Average:27137.63 Median:229244.08 stddev:76315.62 (33.3%) stddev-sans-first:76503.22 23:55:27 INFO - PROCESS | 5686 | Values: 362.8 372.9 377.6 381.5 383.9 16204.6 17501.0 18212.6 18415.5 18607.8 17038.7 17162.3 17376.3 17738.0 17778.7 5120.6 5243.5 5275.7 5282.0 5297.4 3630.0 5181.3 5872.8 6214.0 6218.3 6059.5 6117.6 6122.6 6139.9 6169.4 5945.9 6080.3 6104.0 6108.3 6110.5 5252.4 5264.2 5264.8 5270.8 5335.1 20753.4 21175.7 21366.5 21710.2 21714.1 1970.0 2055.1 2108.9 2125.7 2577.0 13751.6 14097.2 14176.9 14210.5 14342.5 1771.0 1829.0 1835.2 1860.8 1876.9 72320.6 73212.6 73246.6 76793.0 80574.2 9543.7 9712.0 9947.8 10110.3 10498.3 14037.9 14053.3 14118.3 14137.6 14235.0 6760.5 6887.8 7027.0 7102.4 7110.6 6469.1 6471.5 6505.8 6615.6 6629.4 4028.9 4044.3 4157.9 4196.2 4542.2 1673.5 1676.6 1713.2 1857.6 1900.2 769.3 839.8 908.7 916.2 917.2 16629.9 17137.3 17252.3 17752.8 18076.0 887.6 890.3 895.5 947.5 962.6 9642.4 9648.8 9783.3 9884.9 10040.4 453946.0 463283.0 464888.0 467137.0 467202.0 62674.4 84094.8 87521.6 87826.6 88550.0 877.5 883.7 888.5 893.9 896.1 15262.2 15670.8 15688.9 15795.1 15841.5 36481.3 38923.2 39966.0 40258.2 40276.6 54030.7 55625.0 55679.4 56149.4 56840.1 7408.5 7466.5 7468.4 7576.5 7582.8 9045.9 11190.1 12039.5 12116.2 12207.5 10756.8 10803.9 10849.7 11122.4 11226.0 7703.8 10534.8 10633.4 10706.9 10803.6 10432.2 10621.4 10827.8 10999.5 11219.1 7676.2 7701.6 7817.7 7845.6 8155.8 9660.6 10737.2 10985.3 11000.9 11200.9 23:55:27 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | [#3] mootools.html Cycles:180 Average:5347.72 Median:4774.44 stddev:3058.95 (64.1%) stddev-sans-first:3052.93 23:55:27 INFO - PROCESS | 5686 | Values: 1370.0 1397.8 1476.2 1701.8 1705.2 7245.2 7644.2 7791.8 8155.1 8162.1 7917.0 8078.8 8113.3 8179.2 8213.3 2196.3 2254.9 2269.7 2271.1 2274.9 2198.2 2227.0 2238.5 2246.9 2262.5 2173.9 2232.7 2242.8 2250.2 2255.2 2101.3 2111.7 2112.0 2114.7 2128.4 2148.5 2149.6 2151.7 2151.8 2156.7 8102.8 8110.8 8168.5 8190.2 8226.6 4627.0 4656.8 4713.4 4717.2 4730.0 2940.3 3016.5 3087.5 3091.3 3095.2 991.4 993.4 1009.8 1011.5 1025.4 11235.9 11242.3 11298.0 11367.3 11373.4 4099.2 4253.4 4337.7 4344.2 4348.0 8785.0 8886.0 8900.5 8915.9 8932.0 4714.8 4744.4 4761.1 4766.1 4772.7 3645.6 4280.1 4398.0 4398.2 4406.9 3602.7 3644.2 3677.0 3703.3 3747.7 1042.5 1055.9 1087.0 1092.8 1129.4 841.1 844.5 850.8 865.3 875.5 5235.6 5314.1 5438.2 5476.7 5496.1 847.2 850.9 854.4 862.5 863.4 3650.6 3669.0 3698.0 3727.3 3815.0 9982.2 10396.0 10468.2 10487.4 10490.9 10171.4 10259.9 10283.7 10303.1 10348.1 7683.3 7734.1 7757.4 7786.6 7831.4 5201.5 5332.3 5346.4 5447.7 5447.8 9386.2 9394.6 9440.6 9588.2 9686.9 9439.2 9653.2 9667.9 9763.5 9855.2 6035.3 6524.3 6660.5 6769.8 6946.8 7987.4 8049.7 8065.6 8081.6 8141.4 6937.2 7311.0 7365.4 7413.7 7418.9 6696.5 6878.3 7118.2 7169.6 7276.7 6694.7 6753.4 6755.4 6764.0 6796.5 4679.2 4760.9 4776.8 4784.5 4825.4 4719.4 4765.1 4776.1 4784.0 4827.6 23:55:27 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | [#4] prototype.html Cycles:180 Average:4439.94 Median:5125.92 stddev:1296.18 (25.3%) stddev-sans-first:1262.08 23:55:27 INFO - PROCESS | 5686 | Values: 303.1 307.9 310.4 315.7 318.3 4944.5 5052.7 5127.6 5209.1 5224.5 5078.5 5119.9 5125.5 5126.3 5151.0 4043.7 4044.2 4044.4 4053.9 4062.3 3910.9 4012.3 4041.2 4053.5 4065.4 3943.9 3963.2 3980.6 3985.8 4008.9 3957.3 3987.6 4010.2 4011.2 4022.6 3547.8 3562.9 3565.7 3569.7 3571.0 4810.3 4985.0 4992.2 4997.8 5056.3 4583.3 4589.4 4592.0 4601.6 4619.0 5371.3 5388.6 5394.6 5407.1 5414.6 3533.0 3699.0 3704.4 3706.5 3890.7 5554.3 5563.6 5593.6 5594.4 5595.6 3847.6 3848.5 3852.3 3859.4 3866.7 3665.4 3843.4 3901.6 3917.3 3919.9 4414.9 4430.1 4440.0 4442.3 4445.8 5313.1 5331.3 5342.5 5384.1 5394.1 1253.4 1319.2 1329.2 1343.2 1347.3 894.2 902.0 916.8 918.5 928.8 4658.6 4668.3 4672.9 4672.9 4678.2 5410.8 5422.6 5424.6 5443.5 5471.6 4527.8 4680.1 4684.0 4684.4 4701.6 2933.2 2934.1 2939.0 2945.0 2951.3 5157.3 5204.6 5222.5 5226.7 5264.6 5490.6 5631.6 5642.7 5644.9 5659.7 5183.2 5189.4 5200.6 5216.3 5233.0 5493.5 5495.5 5553.6 5561.0 5568.4 5265.6 5409.1 5411.6 5420.8 5427.0 5165.8 5183.9 5192.4 5224.0 5225.9 3806.8 3809.9 3838.9 3844.2 3862.6 5227.9 5369.2 5499.6 5531.7 5547.0 5188.7 5395.8 5398.2 5401.9 5414.7 5308.4 5330.1 5369.4 5371.2 5373.3 5119.6 5254.7 5255.1 5262.9 5276.5 5332.2 5376.0 5389.6 5402.9 5407.5 5254.8 5257.9 5260.5 5275.2 5316.4 23:55:27 INFO - PROCESS | 5686 | 23:55:27 INFO - PROCESS | 5686 | [#5] yui.html Cycles:180 Average:18373.94 Median:560.10 stddev:26798.64 (4784.6%) stddev-sans-first:26840.69 23:55:27 INFO - PROCESS | 5686 | Values: 630.0 648.7 654.4 659.5 753.6 13653.9 13962.3 14468.1 14520.0 14555.6 13760.0 13768.1 13791.4 13882.8 13992.8 619.1 752.6 767.1 776.3 786.1 779.6 786.0 786.4 788.3 791.0 821.6 823.1 824.2 829.1 832.0 818.7 823.6 824.4 824.8 828.1 600.6 600.8 601.3 601.4 602.8 13416.3 13478.7 13482.1 13499.9 13547.9 13771.2 14119.5 14148.8 14201.7 14422.6 10657.4 10833.9 11101.7 11181.8 11182.3 3354.7 3417.6 3429.2 3492.2 3493.0 57122.4 62174.7 62356.4 62507.1 62829.7 11144.4 11173.4 11181.6 11214.4 11383.3 20110.2 20184.0 20212.5 20278.5 20429.9 7080.7 7106.7 7130.5 7212.9 7349.2 3700.1 3825.6 3838.2 3867.7 3886.9 2839.6 2950.9 2956.5 2959.4 3276.8 546.7 556.5 569.8 582.2 591.8 487.6 547.7 563.7 598.5 601.6 8554.9 8612.8 8695.9 8769.8 8861.7 531.3 591.4 604.6 612.9 619.5 4161.9 4168.8 4194.4 4194.6 4209.9 101947.0 103920.0 104538.4 105194.0 105579.0 69843.7 93121.5 93449.8 93547.5 93858.5 75789.6 76796.2 77953.0 80551.6 80738.0 7926.8 7983.3 7993.6 8043.7 8148.3 46052.8 47596.8 49122.8 49445.8 50511.2 46622.0 68457.0 68995.7 70145.0 70983.6 10112.9 10236.1 10370.3 10550.5 10590.5 10675.4 10892.9 10912.7 10942.3 11005.4 10910.3 10976.6 11138.4 11302.8 11333.3 9635.6 9658.8 9813.7 9929.5 9963.2 10619.2 10915.2 11072.3 11252.9 11319.7 9473.1 9526.5 9535.6 9759.8 9871.8 9283.4 9657.4 9661.0 9673.7 9743.8 23:55:27 INFO - PROCESS | 5686 | -------- Summary: end -------- 23:55:27 INFO - PROCESS | 5686 | 23:55:28 INFO - TEST-INFO | 5686: exit 0 23:55:28 INFO - TEST-OK | dromaeo_css | took 1116123ms 23:55:28 INFO - TEST-START | kraken 23:55:28 INFO - operating with platform_type : linux_ 23:55:28 INFO - Initialising browser for kraken test... 23:55:28 INFO - TEST-INFO | started process 5931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbB05wK/profile http://localhost:42996/getInfo.html) 23:55:33 INFO - PROCESS | 5931 | __metrics Screen width/height:1600/1200 23:55:33 INFO - PROCESS | 5931 | colorDepth:24 23:55:33 INFO - PROCESS | 5931 | Browser inner width/height: 1024/697 23:55:33 INFO - PROCESS | 5931 | __metrics 23:55:34 ERROR - PROCESS | 5931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 23:55:34 INFO - TEST-INFO | 5931: exit 0 23:55:34 INFO - Browser initialized. 23:55:34 INFO - Running cycle 1/1 for kraken test... 23:55:34 INFO - TEST-INFO | started process 6053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbB05wK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:55:46 INFO - PROCESS | 6053 | RSS: Main: 169476096 23:55:46 INFO - PROCESS | 6053 | 23:55:49 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42996/tests/kraken/driver.html?testName=audio-beat-detection) 23:55:50 INFO - PROCESS | 6053 | RSS: Main: 174661632 23:55:50 INFO - PROCESS | 6053 | 23:55:53 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42996/tests/kraken/driver.html?testName=audio-dft) 23:55:53 INFO - PROCESS | 6053 | RSS: Main: 173453312 23:55:53 INFO - PROCESS | 6053 | 23:55:56 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42996/tests/kraken/driver.html?testName=audio-fft) 23:55:57 INFO - PROCESS | 6053 | RSS: Main: 168607744 23:55:57 INFO - PROCESS | 6053 | 23:55:59 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42996/tests/kraken/driver.html?testName=audio-oscillator) 23:56:00 INFO - PROCESS | 6053 | RSS: Main: 169164800 23:56:00 INFO - PROCESS | 6053 | 23:56:02 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:56:03 INFO - PROCESS | 6053 | RSS: Main: 169299968 23:56:03 INFO - PROCESS | 6053 | 23:56:06 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42996/tests/kraken/driver.html?testName=imaging-darkroom) 23:56:06 INFO - PROCESS | 6053 | RSS: Main: 169914368 23:56:06 INFO - PROCESS | 6053 | 23:56:10 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42996/tests/kraken/driver.html?testName=imaging-desaturate) 23:56:11 INFO - PROCESS | 6053 | RSS: Main: 167362560 23:56:11 INFO - PROCESS | 6053 | 23:56:13 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42996/tests/kraken/driver.html?testName=json-parse-financial) 23:56:14 INFO - PROCESS | 6053 | RSS: Main: 168501248 23:56:14 INFO - PROCESS | 6053 | 23:56:16 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:56:16 INFO - PROCESS | 6053 | RSS: Main: 168718336 23:56:16 INFO - PROCESS | 6053 | 23:56:18 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:56:19 INFO - PROCESS | 6053 | RSS: Main: 169521152 23:56:19 INFO - PROCESS | 6053 | 23:56:21 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:56:22 INFO - PROCESS | 6053 | RSS: Main: 169619456 23:56:22 INFO - PROCESS | 6053 | 23:56:25 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:56:25 INFO - PROCESS | 6053 | RSS: Main: 169869312 23:56:25 INFO - PROCESS | 6053 | 23:56:28 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:56:29 INFO - PROCESS | 6053 | RSS: Main: 169967616 23:56:29 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:42996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42996/tests/kraken/driver.html?testName=ai-astar) 23:56:31 INFO - PROCESS | 6053 | RSS: Main: 170467328 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | __start_tp_report 23:56:31 INFO - PROCESS | 6053 | _x_x_mozilla_page_load 23:56:31 INFO - PROCESS | 6053 | _x_x_mozilla_page_load_details 23:56:31 INFO - PROCESS | 6053 | |i|pagename|runs| 23:56:31 INFO - PROCESS | 6053 | |0;ai-astar;104;113;108;116;113;114;114;112;113;113 23:56:31 INFO - PROCESS | 6053 | |1;audio-beat-detection;151;124;151;165;126;145;147;137;183;123 23:56:31 INFO - PROCESS | 6053 | |2;audio-dft;165;163;162;165;171;165;162;165;162;162 23:56:31 INFO - PROCESS | 6053 | |3;audio-fft;76;76;77;149;80;77;76;76;167;77 23:56:31 INFO - PROCESS | 6053 | |4;audio-oscillator;86;85;138;86;86;86;138;86;86;135 23:56:31 INFO - PROCESS | 6053 | |5;imaging-gaussian-blur;118;118;118;117;118;117;118;118;119;118 23:56:31 INFO - PROCESS | 6053 | |6;imaging-darkroom;148;149;149;148;147;147;148;147;147;147 23:56:31 INFO - PROCESS | 6053 | |7;imaging-desaturate;95;95;97;95;96;95;96;96;96;95 23:56:31 INFO - PROCESS | 6053 | |8;json-parse-financial;65;64;65;66;64;64;66;64;63;65 23:56:31 INFO - PROCESS | 6053 | |9;json-stringify-tinderbox;68;64;64;66;65;63;64;64;67;65 23:56:31 INFO - PROCESS | 6053 | |10;stanford-crypto-aes;79;80;79;80;80;79;81;80;80;79 23:56:31 INFO - PROCESS | 6053 | |11;stanford-crypto-ccm;128;130;150;146;142;130;131;133;179;134 23:56:31 INFO - PROCESS | 6053 | |12;stanford-crypto-pbkdf2;169;171;167;176;165;169;168;164;167;163 23:56:31 INFO - PROCESS | 6053 | |13;stanford-crypto-sha256-iterative;72;72;68;69;80;67;68;69;67;68 23:56:31 INFO - PROCESS | 6053 | __end_tp_report 23:56:31 INFO - PROCESS | 6053 | __start_cc_report 23:56:31 INFO - PROCESS | 6053 | _x_x_mozilla_cycle_collect,967 23:56:31 INFO - PROCESS | 6053 | __end_cc_report 23:56:31 INFO - PROCESS | 6053 | __startTimestamp1467528991335__endTimestamp 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | ------- Summary: start ------- 23:56:31 INFO - PROCESS | 6053 | Number of tests: 14 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.46 (3.1%) stddev-sans-first:2.15 23:56:31 INFO - PROCESS | 6053 | Values: 104.0 113.0 108.0 116.0 113.0 114.0 114.0 112.0 113.0 113.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:149.00 stddev:19.06 (12.8%) stddev-sans-first:20.10 23:56:31 INFO - PROCESS | 6053 | Values: 151.0 124.0 151.0 165.0 126.0 145.0 147.0 137.0 183.0 123.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:2.78 (1.7%) stddev-sans-first:2.93 23:56:31 INFO - PROCESS | 6053 | Values: 165.0 163.0 162.0 165.0 171.0 165.0 162.0 165.0 162.0 162.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.50 stddev:34.49 (45.1%) stddev-sans-first:36.02 23:56:31 INFO - PROCESS | 6053 | Values: 76.0 76.0 77.0 149.0 80.0 77.0 76.0 76.0 167.0 77.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:86.00 stddev:24.72 (28.7%) stddev-sans-first:25.60 23:56:31 INFO - PROCESS | 6053 | Values: 86.0 85.0 138.0 86.0 86.0 86.0 138.0 86.0 86.0 135.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:56:31 INFO - PROCESS | 6053 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 119.0 118.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 23:56:31 INFO - PROCESS | 6053 | Values: 148.0 149.0 149.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 23:56:31 INFO - PROCESS | 6053 | Values: 95.0 95.0 97.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 23:56:31 INFO - PROCESS | 6053 | Values: 65.0 64.0 65.0 66.0 64.0 64.0 66.0 64.0 63.0 65.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.56 (2.4%) stddev-sans-first:1.22 23:56:31 INFO - PROCESS | 6053 | Values: 68.0 64.0 64.0 66.0 65.0 63.0 64.0 64.0 67.0 65.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 23:56:31 INFO - PROCESS | 6053 | Values: 79.0 80.0 79.0 80.0 80.0 79.0 81.0 80.0 80.0 79.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:138.00 stddev:15.53 (11.3%) stddev-sans-first:15.82 23:56:31 INFO - PROCESS | 6053 | Values: 128.0 130.0 150.0 146.0 142.0 130.0 131.0 133.0 179.0 134.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.50 stddev:3.75 (2.2%) stddev-sans-first:3.96 23:56:31 INFO - PROCESS | 6053 | Values: 169.0 171.0 167.0 176.0 165.0 169.0 168.0 164.0 167.0 163.0 23:56:31 INFO - PROCESS | 6053 | 23:56:31 INFO - PROCESS | 6053 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.00 stddev:3.94 (5.7%) stddev-sans-first:4.12 23:56:31 INFO - PROCESS | 6053 | Values: 72.0 72.0 68.0 69.0 80.0 67.0 68.0 69.0 67.0 68.0 23:56:31 INFO - PROCESS | 6053 | -------- Summary: end -------- 23:56:31 INFO - PROCESS | 6053 | 23:56:32 INFO - TEST-INFO | 6053: exit 0 23:56:32 INFO - TEST-OK | kraken | took 64069ms 23:56:32 INFO - SUITE-END | took 1180s 23:56:32 INFO - Completed test suite (00:19:40) 23:56:32 INFO - javascript benchmark 23:56:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6543.030588908635, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.631431599576, 2682.81220314578, 2698.392861606139, 2698.4198397344567, 2699.959500607491, 4746.596539294155, 4788.664793464459, 4824.565789078983, 4832.106060378833, 4869.513048695128, 4707.4586422561415, 4756.7621618919, 4777.498362671913, 4789.257665061921, 4837.250226214934, 4412.095520418315, 4437.156940181371, 4468.776561171929, 4497.617702495292, 4533.002739397344, 4423.977880110611, 4445.711028783118, 4447.266201076818, 4581.450225972888, 4584.4498660160825, 4490.775461226942, 4498.325251212312, 4500.347449619803, 4516.774161291939, 4539.024109816389, 171.29629235475366, 4404.977975110136, 4508.436445444319, 4508.504064552896, 4531.048479819242, 4377.277749171383, 4383.408239887638, 4390.187815254157, 4402.581754733327, 4443.355713421568, 4706.152892479352, 4759.714417134948, 4784.40194975628, 4796.280557916306, 4798.784054717511, 5012.799488020475, 5054.469280725544, 5095.464976177485, 5123.564497017758, 5129.615278854101, 5122.974385128088, 5127.051495473349, 5194.896102077937, 5212.139996900507, 5259.0270799901755, 4780.043991201704, 4814.037192561502, 4828.372311599504, 4833.637477189225, 4835.1296766581645, 5254.789808407697, 5288.206768984683, 5296.708681022504, 5298.178782288752, 5344.518993290545, 5033.169527028, 5073.188289873602, 5077.035363280965, 5080.364954380702, 5084.618653600995, 5121.564667003272, 5132.358455193101, 5160.845174644766, 5163.40620828602, 5174.172132458789, 5089.923651145235, 5109.565686916654, 5112.130937740519, 5119.155339368963, 5162.948370516322, 5105.744712764421, 5117.406967577154, 5119.795208191705, 5128.333316668809, 5163.741812909339, 4205.894852628648, 4282.678799090018, 4299.269124248885, 4320.179165958458, 4335.978320108379, 3737.831797569116, 3740.0, 3749.4938183345444, 3766.3408903442337, 3793.146542028077, 4470.776461176928, 4482.125985432875, 4501.864944051684, 4513.413256276663, 4538.387317712132, 5049.545540901337, 5145.45972672864, 5175.783690832652, 5213.035588416155, 5264.92102618461, 4544.7045942013665, 4546.681732278775, 4549.226631472658, 4549.658775591844, 4591.609713174351, 4633.72197668141, 4674.322223277606, 4679.3916790816975, 4686.39076920005, 4715.999999999932, 4743.288506724019, 4796.424429068465, 4813.4945830687275, 4871.48849370811, 4876.951455437098, 5141.0232055909255, 5175.870603234949, 5192.818251361185, 5193.792248310026, 5209.453007434165, 4862.854114376574, 4871.683340582851, 4878.024395120919, 4881.707097574157, 4943.925841112458, 4995.975020124876, 5028.924566131438, 5065.645404821627, 5074.3657042869645, 5087.771050302671, 5150.896982060262, 5162.97418512905, 5164.1995490699, 5164.9741751291, 5209.609279303992, 4919.1883339248625, 5018.598512119095, 5018.799248030038, 5020.42265139499, 5024.346834911438, 4972.925406118983, 4992.850214493571, 5031.7484125792835, 5036.647434679538, 5067.315912351785, 4937.950620493749, 5006.0, 5018.1218286800395, 5026.4973502649445, 5088.0587091388215, 4991.775370108281, 5022.045811295842, 5109.20807274873, 5117.334746482933, 5135.998480296306, 4882.584980276574, 4984.327115839315, 4985.6510044298, 5009.499050095107, 5024.57291130258], "value": 4706.936871975107, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3380777586335, 572.4189947203588, 581.4679568195102, 586.5337057039653, 618.5700937848192, 35385.0, 40006.199876002465, 40047.0, 40092.799536002276, 40193.0, 29865.402691946147, 30323.84838075812, 30420.391592168144, 30634.23414414635, 31372.0, 7838.804029899241, 7943.64253608589, 7984.24149705777, 7986.480878742892, 8008.03903531577, 7894.17111203324, 7921.405894557903, 7983.0, 8016.318612917879, 8017.0, 8039.236272554127, 8059.355251579889, 8060.879086813702, 8062.07286162093, 8092.595370231465, 7968.482048666847, 7996.120426753053, 8004.719244920785, 8020.278174964281, 8041.0, 7931.881021784678, 7933.206679332078, 7986.920130798734, 7996.4002699797165, 8011.559364234965, 38860.61139388626, 38917.80541097277, 39107.60892391068, 39183.21633567341, 39262.21475570473, 3166.9208269793207, 3282.195862013822, 3312.5362449257123, 3320.0371892151247, 3387.170143314879, 29906.55140172899, 30437.847810760806, 30690.846545767352, 30791.230219244473, 31398.843005785053, 3454.8618055277757, 3481.860725570974, 3523.312953973976, 3525.330187264437, 3584.6953008994265, 263151.0, 263380.0, 265093.0, 265297.0, 267351.0, 32413.675863241537, 53491.465085349424, 53860.461395385544, 53865.73067134639, 53937.1909421359, 32083.839580802414, 34570.82714586411, 34652.82673586616, 34665.0, 34721.30557388838, 13276.73446531064, 13528.729425411437, 13546.254955977516, 13569.796453053212, 13570.59288221355, 10920.29018113836, 10951.397673127894, 10971.286866353661, 11045.33727976324, 11093.168012399103, 8092.271695547429, 8101.918980810235, 8123.228293312126, 8155.755327340189, 8179.591020448954, 3158.1630867820045, 3161.7470602351755, 3196.1689960609942, 3200.0559834848777, 3217.501287300472, 902.3548163063441, 954.1984732824461, 966.5553845231132, 979.7550612346913, 1016.5679586175846, 28561.28596785097, 28941.710582894324, 29206.123816285544, 29668.554971675443, 29724.256893577833, 937.4515908193647, 995.9253056020827, 1026.5226669598671, 1061.1828891753307, 1062.9574817007233, 14570.708585828224, 14918.0, 14996.175210363535, 15104.471343502924, 15367.61580960485, 408667.0, 413549.0, 415142.0, 415907.0, 416829.0, 49815.75092124516, 50315.74842125766, 50357.49642503528, 50409.747951260746, 50668.239976400386, 1171.3323405658864, 1174.2112482853224, 1177.0465922602718, 1187.0088476122362, 1199.748052908899, 27101.0, 28117.297067572657, 28286.71713282841, 28699.42601148007, 30290.545641815832, 47719.28421073617, 47937.0, 48409.27386089141, 48461.0, 48470.5152948466, 286127.0, 286819.0, 287382.0, 289006.0, 289471.0, 38397.808010959765, 39691.20617587574, 39936.0, 40434.595654043085, 40684.38973415342, 43048.56951430446, 43772.34341484817, 43785.343219852366, 44113.77943110264, 44349.0, 37964.2407151861, 38237.0, 38863.41704874373, 39061.21877562376, 39087.60912390953, 37851.810740946115, 38176.809115954245, 38540.22919541538, 38760.80619596884, 39195.43218271237, 36725.81637091797, 37390.626093739804, 37823.43264851085, 37848.43227351647, 38197.236055279296, 33131.337373252885, 36264.456033159, 37736.62263377441, 37759.0, 38166.618333817416, 26035.349116272246, 26039.609405858548, 26163.0, 26427.207183784518, 26549.203523894314], "value": 17037.013661974197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.84216365880843, 372.8508596561376, 377.5978582809308, 381.4849952564037, 383.8925100971729, 16204.594885127877, 17501.0, 18212.634052446087, 18415.539611509717, 18607.813921860776, 17038.74441883373, 17162.31350745972, 17376.304947802073, 17738.0, 17778.733319000192, 5120.564751996076, 5243.528082472577, 5275.709835959021, 5282.0, 5297.44376840432, 3630.0, 5181.300524429211, 5872.7944521941745, 6213.968930155343, 6218.253809542861, 6059.484943779784, 6117.5717699761035, 6122.602030868002, 6139.8772024559485, 6169.413905678954, 5945.910811337833, 6080.331163572004, 6103.969480152615, 6108.267007959051, 6110.541709371792, 5252.395974462909, 5264.236685680593, 5264.842054738364, 5270.841874743764, 5335.093034184198, 20753.377398678065, 21175.68236476454, 21366.465838354165, 21710.240141594968, 21714.13143474259, 1970.0, 2055.075216152722, 2108.9261875834272, 2125.6811478278228, 2576.9563326852654, 13751.587452376445, 14097.154170749787, 14176.858231417656, 14210.502632407815, 14342.49801256951, 1770.9645807083914, 1829.0397541290795, 1835.183343412182, 1860.7860096088987, 1876.8686191966567, 72320.63839680768, 73212.63393682998, 73246.63376683083, 76793.0, 80574.19425805725, 9543.665971690958, 9712.028797120372, 9947.751306217402, 10110.313377804569, 10498.265121441578, 14037.859621403859, 14053.297335133408, 14118.294085295694, 14137.646558836112, 14235.003549751626, 6760.526763126534, 6887.827804304932, 7027.0, 7102.4318054555515, 7110.608916509642, 6469.126667899867, 6471.47345872365, 6505.772297969548, 6615.569987950767, 6629.370209830058, 4028.91942161161, 4044.2518134145275, 4157.875263742032, 4196.223698615705, 4542.159700455426, 1673.5230459319037, 1676.597616572014, 1713.2461716844548, 1857.600615867568, 1900.1829213438355, 769.2999370572752, 839.8362319347668, 908.7182973278304, 916.1800188830958, 917.1607978699416, 16629.91685041567, 17137.314507419815, 17252.309907603805, 17752.822471775376, 18076.0, 887.5606574745542, 890.2610833008588, 895.5387975192781, 947.4552132523827, 962.6486332488591, 9642.373245739005, 9648.807023859483, 9783.266255030901, 9884.851727224097, 10040.397576145455, 453946.0, 463283.0, 464888.0, 467137.0, 467202.0, 62674.37325626777, 84094.79526023674, 87521.5623921889, 87826.56086719525, 88550.0, 877.4691311756424, 883.6774577279247, 888.4757992784417, 893.8525143351404, 896.050186801992, 15262.23688815577, 15670.843291567395, 15688.92155539215, 15795.131267780382, 15841.52475425739, 36481.270374591826, 38923.2215355697, 39966.0, 40258.1948361037, 40276.597234027286, 54030.729846350514, 55625.0, 55679.443205567426, 56149.43850561605, 56840.14739778989, 7408.518446300973, 7466.477346585687, 7468.402527797872, 7576.545407275581, 7582.810429739301, 9045.909540904508, 11190.104791616814, 12039.518419263131, 12116.21244619097, 12207.45066471993, 10756.784864302826, 10803.891961080602, 10849.728756781144, 11122.388268645302, 11226.0, 7703.845923081395, 10534.789304214026, 10633.415162166155, 10706.89293107059, 10803.621873234399, 10432.165426765992, 10621.415822129857, 10827.837582436112, 10999.450027498433, 11219.102471802073, 7676.232376762279, 7701.576413297323, 7817.726379576688, 7845.5684937329, 8155.83688326242, 9660.613575456902, 10737.248392612755, 10985.340879547253, 11000.889991099986, 11200.943995279971], "value": 8561.36144109872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.9794503082455, 1397.8322601287844, 1476.2028504607513, 1701.7617533545313, 1705.1985566783608, 7245.203027666952, 7644.235576442353, 7791.766247012584, 8155.062167850699, 8162.14297498763, 7917.049954005513, 8078.838423231547, 8113.269805717484, 8179.222973817493, 8213.26080652741, 2196.3301193136085, 2254.9436264093447, 2269.706267427567, 2271.1483193802324, 2274.931752047441, 2198.164697414988, 2226.955460890781, 2238.541099074686, 2246.8988895499742, 2262.468319944812, 2173.880436575988, 2232.687423760675, 2242.831787615927, 2250.2124256510174, 2255.22194842779, 2101.3485819395883, 2111.7043613894066, 2112.028466905233, 2114.6722258050027, 2128.446603882986, 2148.516583768655, 2149.57008598281, 2151.709519214902, 2151.8386121040985, 2156.698062271283, 8102.7569172924905, 8110.837783244302, 8168.509889406655, 8190.180981901822, 8226.629801658939, 4626.953730462719, 4656.790444429975, 4713.410823647044, 4717.2452407614965, 4729.9763501182615, 2940.2502361897577, 3016.547517872315, 3087.4751292280366, 3091.2580980564726, 3095.2107212660626, 991.3952488981715, 993.438707130469, 1009.8434742614907, 1011.5094179323022, 1025.374521541859, 11235.887641123647, 11242.269252498561, 11298.0, 11367.317960922372, 11373.374464404455, 4099.241640296555, 4253.404523366731, 4337.652987760972, 4344.174606824757, 4347.956520434818, 8785.033646298902, 8886.0, 8900.465972041698, 8915.910840891638, 8932.017478077407, 4714.787834547385, 4744.430668319755, 4761.071591039783, 4766.142094423037, 4772.737499437564, 3645.6354364563863, 4280.101178752435, 4397.9560204398185, 4398.186335527937, 4406.911861762811, 3602.7117830574016, 3644.21649345392, 3676.963230367662, 3703.2593481303848, 3747.6508456955476, 1042.5360714482135, 1055.894410558938, 1086.9782604347868, 1092.830611255241, 1129.3901293301526, 841.1000229754104, 844.4511067805976, 850.8000619854329, 865.2558799432483, 875.5053394831899, 5235.58115350771, 5314.1497360422145, 5438.157085651651, 5476.67139971603, 5496.148097044965, 847.1570787066785, 850.9405789791625, 854.3933806996978, 862.4523427623504, 863.4301361101643, 3650.580183278904, 3668.981655091761, 3697.9815100924325, 3727.329080765434, 3815.0, 9982.201423886072, 10396.0, 10468.214883883738, 10487.37075775456, 10490.947545262225, 10171.389716617026, 10259.948700256451, 10283.742906427398, 10303.124234440156, 10348.120409765104, 7683.346915512132, 7734.1492435832015, 7757.4181936355, 7786.57173855432, 7831.412644051605, 5201.479852014768, 5332.33345831771, 5346.4228052723765, 5447.700376479332, 5447.836564902901, 9386.249100072115, 9394.577244023898, 9440.622375104918, 9588.232941364813, 9686.854697179408, 9439.197668198005, 9653.227741780782, 9667.9033209667, 9763.463009534544, 9855.21158307348, 6035.275766907999, 6524.2823289439075, 6660.500462465431, 6769.796906092825, 6946.826329341807, 7987.361011119213, 8049.718259860877, 8065.637046332812, 8081.595920203848, 8141.3893957952205, 6937.202221744362, 7311.0, 7365.447591430771, 7413.703451862081, 7418.925810742039, 6696.497762667722, 6878.27778083294, 7118.181409138016, 7169.641517924188, 7276.745313913988, 6694.698738556874, 6753.3921947025, 6755.392014718699, 6763.966180169265, 6796.490263230178, 4679.181143299841, 4760.857174284777, 4776.761161941819, 4784.521547845187, 4825.445073816416, 4719.3628860103445, 4765.142274390504, 4776.140294746979, 4783.995360974234, 4827.61379089679], "value": 4270.053827326569, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.0877060049252, 307.9045495896272, 310.39008348595013, 315.73951490020727, 318.2965645922514, 4944.5055494450535, 5052.722100284483, 5127.615428842838, 5209.114450543408, 5224.503672151149, 5078.5175408336245, 5119.928043174094, 5125.538701516863, 5126.307948426961, 5150.974245128769, 4043.716939814214, 4044.231595996766, 4044.352903535435, 4053.898652533681, 4062.329715596923, 3910.863119790808, 4012.3379642358977, 4041.1917616476676, 4053.513578370585, 4065.369867670501, 3943.940840887389, 3963.2271707017, 3980.646580162744, 3985.8007099645047, 4008.9198216035807, 3957.3074711925588, 3987.5613682494904, 4010.2380547696134, 4011.2178125265586, 4022.597740225983, 3547.7516573839844, 3562.8931132066077, 3565.732570057256, 3569.714422846166, 3571.017970058255, 4810.326554282403, 4985.0, 4992.176290911995, 4997.800087996476, 5056.317397151374, 4583.335416364608, 4589.426321709786, 4591.977040114778, 4601.585857272861, 4619.006913513577, 5371.328583927009, 5388.568914486832, 5394.626364399652, 5407.134858422673, 5414.620976531644, 3532.9646703532894, 3698.981505092457, 3704.37025705628, 3706.499622550948, 3890.727649064567, 5554.333479982388, 5563.554915606742, 5593.552515798767, 5594.384617692051, 5595.552355811566, 3847.5960024197057, 3848.5381754189675, 3852.3451013327804, 3859.4017927221325, 3866.7293289469467, 3665.395209790355, 3843.36584463566, 3901.6098390160755, 3917.3144699678014, 3919.9216015679526, 4414.933775993362, 4430.13612345596, 4439.955600444019, 4442.333649952533, 4445.755483448376, 5313.123334649817, 5331.280277162611, 5342.545883599938, 5384.0847056000575, 5394.08300588893, 1253.3921048291572, 1319.2348437905991, 1329.2157627000117, 1343.2343564168525, 1347.2724728646617, 894.1639567004871, 901.9954900225457, 916.7708072981754, 918.4581097152578, 928.79102202004, 4658.552671023486, 4668.346431499593, 4672.906541869143, 4672.929906051412, 4678.204705200124, 5410.83767486976, 5422.6475279106735, 5424.62027658068, 5443.537299329522, 5471.5896307777075, 4527.818887244473, 4680.063987202573, 4684.0, 4684.391029166255, 4701.553352431513, 2933.2080338308538, 2934.105097945147, 2939.0448104366164, 2945.0, 2951.3064429858964, 5157.277981082651, 5204.583633309327, 5222.5376894468845, 5226.712530810766, 5264.6051546134195, 5490.615656903979, 5631.605787594829, 5642.7178641067785, 5644.887102258014, 5659.660420374791, 5183.196604526304, 5189.391288700515, 5200.609954253446, 5216.295800067019, 5232.9738351308, 5493.450654934634, 5495.477929596682, 5553.6390134641115, 5561.0, 5568.443155684399, 5265.578753699771, 5409.107497263065, 5411.567074633941, 5420.810271640474, 5426.972865135649, 5165.793368265227, 5183.896322073462, 5192.402873669425, 5224.0, 5225.869353266199, 3806.8477260909253, 3809.8857034287907, 3838.9040273993373, 3844.2119365530557, 3862.594427585063, 5227.92158117621, 5369.19462080691, 5499.587530935116, 5531.7234138292115, 5547.0, 5188.7405629719115, 5395.838124856261, 5398.1902714593125, 5401.8919621606565, 5414.7021913795115, 5308.442613525679, 5330.148370621699, 5369.382521009978, 5371.221172929982, 5373.301470808769, 5119.590432765444, 5254.6847189168775, 5255.106631872667, 5262.9210561842365, 5276.5251127398715, 5332.22682710997, 5376.0, 5389.568834493152, 5402.891942161214, 5407.459254074561, 5254.816081437131, 5257.947420525746, 5260.473952604709, 5275.180062878301, 5316.388615309289], "value": 4025.1163899712183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.9622022678639, 648.7242921758254, 654.4012228810639, 659.4807834073838, 753.6495529578748, 13653.931730341346, 13962.301884905764, 14468.131912085282, 14520.0, 14555.617216364455, 13760.036797424184, 13768.105073170236, 13791.379387927542, 13882.79175812361, 13992.790108148385, 619.0590302739855, 752.586077657289, 767.1024900865987, 776.2780614028951, 786.0645831460572, 779.5712358202994, 785.956772377519, 786.3905473258242, 788.286600626434, 790.9920900791004, 821.5604651511443, 823.1357075071181, 824.1634740738156, 829.0548774397192, 831.9500829950192, 818.6520728690283, 823.5758584329076, 824.3652387661527, 824.7938015496126, 828.0725587342155, 600.5975996082635, 600.8197540737805, 601.3445344574435, 601.3986013986014, 602.8071017274474, 13416.329183540882, 13478.730425391437, 13482.12366196204, 13499.932500337436, 13547.932260338635, 13771.173729576258, 14119.505817296447, 14148.787768183383, 14201.727723564283, 14422.639434014129, 10657.360558366445, 10833.945830270877, 11101.72245693856, 11181.776364472666, 11182.32906025633, 3354.748393870445, 3417.5557177567007, 3429.228423604694, 3492.2142517933517, 3493.0, 57122.42877571254, 62174.689126554076, 62356.376436235965, 62507.06239406412, 62829.68585157045, 11144.387058711687, 11173.441327933571, 11181.608643697595, 11214.439278036229, 11383.260088094248, 20110.195592176442, 20184.0, 20212.494687632927, 20278.49303767388, 20429.897850510653, 7080.716771329192, 7106.71573137079, 7130.465215108888, 7212.891806622905, 7349.191588925214, 3700.1119731264303, 3825.6365645264214, 3838.1747924195874, 3867.7485963412287, 3886.941695874564, 2839.6024556562097, 2950.8524573771224, 2956.51217549102, 2959.3785305085744, 3276.836158192081, 546.7075114813636, 556.4630131922714, 569.8205065404385, 582.1500609110661, 591.7662523303358, 487.61478432039, 547.6686604604237, 563.7378618942212, 598.5211830535554, 601.59392410123, 8554.91445085541, 8612.78468038304, 8695.869511969608, 8769.824603508021, 8861.73414797557, 531.2801154435762, 591.4056373344761, 604.5858586867921, 612.8804883047762, 619.5105866365611, 4161.854335098257, 4168.782420821031, 4194.387623378954, 4194.601512856274, 4209.936850947238, 101946.98053019374, 103920.0, 104538.36462895201, 105194.0, 105579.0, 69843.65078174678, 93121.53439232761, 93449.79475923463, 93547.53226233962, 93858.53070734603, 75789.62105189549, 76796.23203768002, 77952.99999999886, 80551.59724201342, 80738.0, 7926.762197134095, 7983.281504664608, 7993.600319984093, 8043.6782528698195, 8148.307393871587, 46052.7697361511, 47596.7620161897, 49122.75438622784, 49445.752771235915, 50511.24233136579, 46622.0, 68457.0, 68995.65502172457, 70145.0, 70983.64508177426, 10112.949435252776, 10236.129928955825, 10370.27408081427, 10550.472476375997, 10590.4704764763, 10675.412852293199, 10892.891071089187, 10912.672619821418, 10942.288751231144, 11005.449727513753, 10910.345379277269, 10976.560937562408, 11138.438159223262, 11302.773944521228, 11333.32000079965, 9635.614575416905, 9658.7585310365, 9813.656522021694, 9929.453880036668, 9963.202943764336, 10619.203559732896, 10915.181361397768, 11072.280301780358, 11252.887471125185, 11319.717007074889, 9473.100055494717, 9526.47604381738, 9535.570899309409, 9759.80480390374, 9871.753206169904, 9283.39657922233, 9657.372270802376, 9660.95169524176, 9673.70978870635, 9743.756406089904], "value": 6648.781940024685, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 108.0, 116.0, 113.0, 114.0, 114.0, 112.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 151.0, 165.0, 126.0, 145.0, 147.0, 137.0, 183.0, 123.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 165.0, 171.0, 165.0, 162.0, 165.0, 162.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 149.0, 80.0, 77.0, 76.0, 76.0, 167.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 138.0, 86.0, 86.0, 86.0, 138.0, 86.0, 86.0, 135.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 66.0, 64.0, 64.0, 66.0, 64.0, 63.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 64.0, 66.0, 65.0, 63.0, 64.0, 64.0, 67.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 80.0, 79.0, 81.0, 80.0, 80.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 150.0, 146.0, 142.0, 130.0, 131.0, 133.0, 179.0, 134.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 167.0, 176.0, 165.0, 169.0, 168.0, 164.0, 167.0, 163.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 68.0, 69.0, 80.0, 67.0, 68.0, 69.0, 67.0, 68.0], "value": 70.0, "unit": "score"}]}]} 23:56:32 INFO - Return code: 0 23:56:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:56:32 ERROR - # TBPL SUCCESS # 23:56:32 INFO - Running post-action listener: _resource_record_post_action 23:56:32 INFO - ##### 23:56:32 INFO - ##### Finished run-tests step (success) 23:56:32 INFO - ##### 23:56:32 INFO - Running post-run listener: _resource_record_post_run 23:56:32 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 139264; Write bytes: 299302912; Read time: 40; Write time: 185348 23:56:32 INFO - TinderboxPrint: CPU usage
13.3% 23:56:32 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 40 23:56:32 INFO - TinderboxPrint: I/O write bytes / time
299,302,912 / 185,348 23:56:32 INFO - TinderboxPrint: CPU idle
8,282.3 (86.7%) 23:56:32 INFO - TinderboxPrint: CPU user
1,217.5 (12.7%) 23:56:32 INFO - TinderboxPrint: Swap in / out
0 / 0 23:56:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1191936; Read time: 0; Write time: 44 23:56:32 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 135168; Write bytes: 298110976; Read time: 24; Write time: 185304 23:56:33 INFO - Running post-run listener: _upload_blobber_files 23:56:33 INFO - Blob upload gear active. 23:56:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:56:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:56:33 INFO - (blobuploader) - INFO - Open directory for files ... 23:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:56:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:34 INFO - (blobuploader) - INFO - Done attempting. 23:56:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:56:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:56:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:37 INFO - (blobuploader) - INFO - Done attempting. 23:56:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:56:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:56:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:56:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:56:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:56:38 INFO - (blobuploader) - INFO - Done attempting. 23:56:38 INFO - (blobuploader) - INFO - Iteration through files over. 23:56:38 INFO - Return code: 0 23:56:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:56:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:56:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/96b51010613bb322dc86f121cedfe01aa90f5b3889a9f966d57672bf1e2b275dac256d3d4aa009573e6b7220295b21f315fe21c3f37c963e681da7277b48c511", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ed54561afdbbb732a04457c21b04275af1f6553e16704ee82b9df1e17ed1a7662d1c874ba4ac281ec47bef94e4636b1528a939ba7b197537cf70a480f834ea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/73dc25a1850e765171fa2cd4e87ddf5f5c7518ecbc1e2f00659763a485477c4576f21fadd678ce1e7d1563eab85d3581f4b9afc1dd7086ea8649e361efc49fee"} 23:56:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:56:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:56:38 INFO - Contents: 23:56:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/96b51010613bb322dc86f121cedfe01aa90f5b3889a9f966d57672bf1e2b275dac256d3d4aa009573e6b7220295b21f315fe21c3f37c963e681da7277b48c511", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ed54561afdbbb732a04457c21b04275af1f6553e16704ee82b9df1e17ed1a7662d1c874ba4ac281ec47bef94e4636b1528a939ba7b197537cf70a480f834ea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/73dc25a1850e765171fa2cd4e87ddf5f5c7518ecbc1e2f00659763a485477c4576f21fadd678ce1e7d1563eab85d3581f4b9afc1dd7086ea8649e361efc49fee"} 23:56:38 INFO - Running post-run listener: copy_logs_to_upload_dir 23:56:38 INFO - Copying logs to upload dir... 23:56:38 INFO - mkdir: /builds/slave/test/build/upload/logs 23:56:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.850647 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-02 23:56:38.916191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:56:38.919768) ========= 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=41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/96b51010613bb322dc86f121cedfe01aa90f5b3889a9f966d57672bf1e2b275dac256d3d4aa009573e6b7220295b21f315fe21c3f37c963e681da7277b48c511", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ed54561afdbbb732a04457c21b04275af1f6553e16704ee82b9df1e17ed1a7662d1c874ba4ac281ec47bef94e4636b1528a939ba7b197537cf70a480f834ea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/73dc25a1850e765171fa2cd4e87ddf5f5c7518ecbc1e2f00659763a485477c4576f21fadd678ce1e7d1563eab85d3581f4b9afc1dd7086ea8649e361efc49fee"} build_url:https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/96b51010613bb322dc86f121cedfe01aa90f5b3889a9f966d57672bf1e2b275dac256d3d4aa009573e6b7220295b21f315fe21c3f37c963e681da7277b48c511", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ed54561afdbbb732a04457c21b04275af1f6553e16704ee82b9df1e17ed1a7662d1c874ba4ac281ec47bef94e4636b1528a939ba7b197537cf70a480f834ea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/73dc25a1850e765171fa2cd4e87ddf5f5c7518ecbc1e2f00659763a485477c4576f21fadd678ce1e7d1563eab85d3581f4b9afc1dd7086ea8649e361efc49fee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:56:38.945651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:56:38.946026) ========= 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=41a7e32711b8e08598a63237000001d6-1467527760.233734-1360461745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:56:39.028510) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:56:39.028857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:56:39.029186) ========= ========= Total master_lag: 0.17 =========