builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1452401904.62 results: success (0) buildid: 20160109201930 builduid: 6ab4ce7498044f0bb7ceb3c4820aaeb5 revision: 1764c03305e60d6b9bee7308670d237ddb7767a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.624187) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.624716) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.625084) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.687940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.688277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.862395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.862705) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.961674) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.962292) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.963058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.963638) ========= 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=62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 20:58:25-- 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% 220M=0s 2016-01-09 20:58:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.562317 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.567723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.568078) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019987 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.617840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.618234) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1764c03305e60d6b9bee7308670d237ddb7767a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1764c03305e60d6b9bee7308670d237ddb7767a0 --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=62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 20:58:25,889 truncating revision to first 12 chars 2016-01-09 20:58:25,889 Setting DEBUG logging. 2016-01-09 20:58:25,889 attempt 1/10 2016-01-09 20:58:25,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1764c03305e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 20:58:26,181 unpacking tar archive at: fx-team-1764c03305e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.595746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:26.226543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:26.226917) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:26.234546) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:26.234944) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:26.235406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-01-09 20:58:26.235795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:58:26 INFO - MultiFileLogger online at 20160109 20:58:26 in /builds/slave/test 20:58:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:58:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:58:26 INFO - {'append_to_log': False, 20:58:26 INFO - 'base_work_dir': '/builds/slave/test', 20:58:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:58:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:58:26 INFO - 'branch': 'Fx-Team-Non-PGO', 20:58:26 INFO - 'buildbot_json_path': 'buildprops.json', 20:58:26 INFO - 'config_files': ('talos/linux_config.py',), 20:58:26 INFO - 'default_actions': ('clobber', 20:58:26 INFO - 'read-buildbot-config', 20:58:26 INFO - 'download-and-extract', 20:58:26 INFO - 'populate-webroot', 20:58:26 INFO - 'create-virtualenv', 20:58:26 INFO - 'install', 20:58:26 INFO - 'run-tests'), 20:58:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:58:26 INFO - 'download_minidump_stackwalk': True, 20:58:26 INFO - 'download_symbols': 'ondemand', 20:58:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:58:26 INFO - 'tooltool.py': '/tools/tooltool.py', 20:58:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:58:26 INFO - '/tools/misc-python/virtualenv.py')}, 20:58:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:58:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:58:26 INFO - 'installer_path': 'installer.exe', 20:58:26 INFO - 'log_level': 'info', 20:58:26 INFO - 'log_name': 'talos', 20:58:26 INFO - 'log_to_console': True, 20:58:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:58:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:58:26 INFO - 'opt_config_files': (), 20:58:26 INFO - 'pip_index': False, 20:58:26 INFO - 'sps_profile': False, 20:58:26 INFO - 'sps_profile_interval': 0, 20:58:26 INFO - 'suite': 'dromaeojs-e10s', 20:58:26 INFO - 'system_bits': '32', 20:58:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:58:26 INFO - 'title': 'talos-linux64-ix-018', 20:58:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:58:26 INFO - 'use_talos_json': True, 20:58:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:58:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:58:26 INFO - 'work_dir': 'build'} 20:58:26 INFO - ##### 20:58:26 INFO - ##### Running clobber step. 20:58:26 INFO - ##### 20:58:26 INFO - Running pre-action listener: _resource_record_pre_action 20:58:26 INFO - Running main action method: clobber 20:58:26 INFO - rmtree: /builds/slave/test/build 20:58:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:58:27 INFO - Running post-action listener: _resource_record_post_action 20:58:27 INFO - ##### 20:58:27 INFO - ##### Running read-buildbot-config step. 20:58:27 INFO - ##### 20:58:27 INFO - Running pre-action listener: _resource_record_pre_action 20:58:27 INFO - Running main action method: read_buildbot_config 20:58:27 INFO - Using buildbot properties: 20:58:27 INFO - { 20:58:27 INFO - "project": "", 20:58:27 INFO - "product": "firefox", 20:58:27 INFO - "script_repo_revision": "production", 20:58:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:58:27 INFO - "repository": "", 20:58:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 20:58:27 INFO - "buildid": "20160109201930", 20:58:27 INFO - "pgo_build": "False", 20:58:27 INFO - "basedir": "/builds/slave/test", 20:58:27 INFO - "buildnumber": 938, 20:58:27 INFO - "slavename": "talos-linux64-ix-018", 20:58:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:58:27 INFO - "platform": "ubuntu64_hw", 20:58:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:58:27 INFO - "branch": "fx-team", 20:58:27 INFO - "repo_path": "integration/fx-team", 20:58:27 INFO - "revision": "1764c03305e60d6b9bee7308670d237ddb7767a0", 20:58:27 INFO - "stage_platform": "linux64", 20:58:27 INFO - "builduid": "6ab4ce7498044f0bb7ceb3c4820aaeb5", 20:58:27 INFO - "slavebuilddir": "test" 20:58:27 INFO - } 20:58:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:58:27 INFO - Running post-action listener: _resource_record_post_action 20:58:27 INFO - ##### 20:58:27 INFO - ##### Running download-and-extract step. 20:58:27 INFO - ##### 20:58:27 INFO - Running pre-action listener: _resource_record_pre_action 20:58:27 INFO - Running main action method: download_and_extract 20:58:27 INFO - mkdir: /builds/slave/test/build/tests 20:58: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')]} 20:58:27 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json 20:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json 20:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:58:32 INFO - Downloaded 1302 bytes. 20:58:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:58:32 INFO - Using the following test package requirements: 20:58:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:58:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:58:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:32 INFO - u'jsshell-linux-x86_64.zip'], 20:58:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:58:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:58:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:58:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:58:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:58:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:58:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:58:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:58:32 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')]} 20:58:32 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:58:33 INFO - Downloaded 22761271 bytes. 20:58:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:58:34 INFO - Return code: 0 20:58:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:58: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')]} 20:58:34 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:58:47 INFO - Downloaded 22761271 bytes. 20:58:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:58:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:58:48 INFO - Return code: 0 20:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:48 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:58:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:58:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:58:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:58:49 INFO - Downloaded 11132285 bytes. 20:58:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 20:58:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:58:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:58:49 INFO - Return code: 0 20:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:49 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:58:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:58:51 INFO - Downloaded 54052138 bytes. 20:58:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:51 INFO - mkdir: /builds/slave/test/properties 20:58:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:58:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:58:51 INFO - Contents: 20:58:51 INFO - build_url:https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:51 INFO - Running post-action listener: _resource_record_post_action 20:58:51 INFO - Running post-action listener: set_extra_try_arguments 20:58:51 INFO - ##### 20:58:51 INFO - ##### Running populate-webroot step. 20:58:51 INFO - ##### 20:58:51 INFO - Running pre-action listener: _resource_record_pre_action 20:58:51 INFO - Running main action method: populate_webroot 20:58:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:58:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:58:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:58:51 INFO - '--tppagecycles', 20:58:51 INFO - '7'], 20:58:51 INFO - 'tests': ['tsvgm']}}, 20:58:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:58:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:58:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:58:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:58:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:58:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:51 INFO - 'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:58:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:51 INFO - 'tests': ['damp', 'tps']}, 20:58:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:51 INFO - 'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['damp', 'tps']}, 20:58:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:58:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:58:51 INFO - 'other': {'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore']}, 20:58:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore']}, 20:58:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore']}, 20:58:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore']}, 20:58:51 INFO - 'other_l64': {'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore']}, 20:58:51 INFO - 'other_nol64': {'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore']}, 20:58:51 INFO - 'svgr': {'tests': ['tsvgx', 20:58:51 INFO - 'tsvgr_opacity', 20:58:51 INFO - 'tart', 20:58:51 INFO - 'tscrollx', 20:58:51 INFO - 'cart']}, 20:58:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['tsvgx', 20:58:51 INFO - 'tsvgr_opacity', 20:58:51 INFO - 'tart', 20:58:51 INFO - 'tscrollx', 20:58:51 INFO - 'cart']}, 20:58:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:51 INFO - 'tests': ['tp5o']}, 20:58:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:51 INFO - 'talos_options': ['--e10s'], 20:58:51 INFO - 'tests': ['tp5o']}, 20:58:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:51 INFO - 'talos_options': ['--xperf_path', 20:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:58:51 INFO - 'tests': ['tp5n']}, 20:58:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:51 INFO - 'talos_options': ['--e10s', 20:58:51 INFO - '--xperf_path', 20:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:58:51 INFO - 'tests': ['tp5n']}}, 20:58:51 INFO - 'talos.zip': {'path': '', 20:58:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:58:51 INFO - Running post-action listener: _resource_record_post_action 20:58:51 INFO - ##### 20:58:51 INFO - ##### Running create-virtualenv step. 20:58:51 INFO - ##### 20:58:51 INFO - Running pre-action listener: _resource_record_pre_action 20:58:51 INFO - Running main action method: create_virtualenv 20:58:51 INFO - Creating virtualenv /builds/slave/test/build/venv 20:58:51 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 20:58:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:58:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:58:51 INFO - Using real prefix '/usr' 20:58:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:58:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:58:53 INFO - Installing pip.................done. 20:58:53 INFO - Return code: 0 20:58:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:58:53 INFO - Using env: {'DISPLAY': ':0', 20:58:53 INFO - 'HOME': '/home/cltbld', 20:58:53 INFO - 'LANG': 'en_US.UTF-8', 20:58:53 INFO - 'LANGUAGE': 'en_US:en', 20:58:53 INFO - 'LOGNAME': 'cltbld', 20:58:53 INFO - 'MAIL': '/var/mail/cltbld', 20:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:53 INFO - 'MOZ_NO_REMOTE': '1', 20:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:53 INFO - 'NO_EM_RESTART': '1', 20:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:53 INFO - 'PWD': '/builds/slave/test', 20:58:53 INFO - 'SHELL': '/bin/bash', 20:58:53 INFO - 'SHLVL': '1', 20:58:53 INFO - 'TERM': 'linux', 20:58:53 INFO - 'TMOUT': '86400', 20:58:53 INFO - 'USER': 'cltbld', 20:58:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:53 INFO - '_': '/tools/buildbot/bin/python'} 20:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:53 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 20:58:53 INFO - Cleaning up... 20:58:53 INFO - Return code: 0 20:58:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 20:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 20:58:53 INFO - Using env: {'DISPLAY': ':0', 20:58:53 INFO - 'HOME': '/home/cltbld', 20:58:53 INFO - 'LANG': 'en_US.UTF-8', 20:58:53 INFO - 'LANGUAGE': 'en_US:en', 20:58:53 INFO - 'LOGNAME': 'cltbld', 20:58:53 INFO - 'MAIL': '/var/mail/cltbld', 20:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:53 INFO - 'MOZ_NO_REMOTE': '1', 20:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:53 INFO - 'NO_EM_RESTART': '1', 20:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:53 INFO - 'PWD': '/builds/slave/test', 20:58:53 INFO - 'SHELL': '/bin/bash', 20:58:53 INFO - 'SHLVL': '1', 20:58:53 INFO - 'TERM': 'linux', 20:58:53 INFO - 'TMOUT': '86400', 20:58:53 INFO - 'USER': 'cltbld', 20:58:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:53 INFO - '_': '/tools/buildbot/bin/python'} 20:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:54 INFO - Downloading/unpacking psutil>=0.7.1 20:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:58:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:58:55 INFO - Installing collected packages: psutil 20:58:55 INFO - Running setup.py install for psutil 20:58:56 INFO - building 'psutil._psutil_linux' extension 20:58:56 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 20:58:56 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 20:58:56 INFO - building 'psutil._psutil_posix' extension 20:58:56 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 20:58:56 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 20:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:58:56 INFO - Successfully installed psutil 20:58:56 INFO - Cleaning up... 20:58:56 INFO - Return code: 0 20:58:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 20:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 20:58:56 INFO - Using env: {'DISPLAY': ':0', 20:58:56 INFO - 'HOME': '/home/cltbld', 20:58:56 INFO - 'LANG': 'en_US.UTF-8', 20:58:56 INFO - 'LANGUAGE': 'en_US:en', 20:58:56 INFO - 'LOGNAME': 'cltbld', 20:58:56 INFO - 'MAIL': '/var/mail/cltbld', 20:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:56 INFO - 'MOZ_NO_REMOTE': '1', 20:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:56 INFO - 'NO_EM_RESTART': '1', 20:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:56 INFO - 'PWD': '/builds/slave/test', 20:58:56 INFO - 'SHELL': '/bin/bash', 20:58:56 INFO - 'SHLVL': '1', 20:58:56 INFO - 'TERM': 'linux', 20:58:56 INFO - 'TMOUT': '86400', 20:58:56 INFO - 'USER': 'cltbld', 20:58:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:56 INFO - '_': '/tools/buildbot/bin/python'} 20:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:58:58 INFO - Installing collected packages: mozsystemmonitor 20:58:58 INFO - Running setup.py install for mozsystemmonitor 20:58:58 INFO - Successfully installed mozsystemmonitor 20:58:58 INFO - Cleaning up... 20:58:58 INFO - Return code: 0 20:58:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:58:58 INFO - Using env: {'DISPLAY': ':0', 20:58:58 INFO - 'HOME': '/home/cltbld', 20:58:58 INFO - 'LANG': 'en_US.UTF-8', 20:58:58 INFO - 'LANGUAGE': 'en_US:en', 20:58:58 INFO - 'LOGNAME': 'cltbld', 20:58:58 INFO - 'MAIL': '/var/mail/cltbld', 20:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:58 INFO - 'MOZ_NO_REMOTE': '1', 20:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:58 INFO - 'NO_EM_RESTART': '1', 20:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:58 INFO - 'PWD': '/builds/slave/test', 20:58:58 INFO - 'SHELL': '/bin/bash', 20:58:58 INFO - 'SHLVL': '1', 20:58:58 INFO - 'TERM': 'linux', 20:58:58 INFO - 'TMOUT': '86400', 20:58:58 INFO - 'USER': 'cltbld', 20:58:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:58 INFO - '_': '/tools/buildbot/bin/python'} 20:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:00 INFO - Downloading blobuploader-1.2.4.tar.gz 20:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:59:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:59:00 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 20:59:00 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 20:59:00 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 20:59:00 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 20:59:00 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 20:59:00 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 20:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:59:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:59:01 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 20:59:01 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 20:59:01 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 20:59:01 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 20:59:01 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 20:59:01 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 20:59:01 INFO - Downloading docopt-0.6.1.tar.gz 20:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:59:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:59:01 INFO - Running setup.py install for blobuploader 20:59:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:59:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:59:01 INFO - Running setup.py install for requests 20:59:01 INFO - Running setup.py install for docopt 20:59:02 INFO - Successfully installed blobuploader requests docopt 20:59:02 INFO - Cleaning up... 20:59:02 INFO - Return code: 0 20:59:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 20:59:02 INFO - Using env: {'DISPLAY': ':0', 20:59:02 INFO - 'HOME': '/home/cltbld', 20:59:02 INFO - 'LANG': 'en_US.UTF-8', 20:59:02 INFO - 'LANGUAGE': 'en_US:en', 20:59:02 INFO - 'LOGNAME': 'cltbld', 20:59:02 INFO - 'MAIL': '/var/mail/cltbld', 20:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:02 INFO - 'MOZ_NO_REMOTE': '1', 20:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:02 INFO - 'NO_EM_RESTART': '1', 20:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:02 INFO - 'PWD': '/builds/slave/test', 20:59:02 INFO - 'SHELL': '/bin/bash', 20:59:02 INFO - 'SHLVL': '1', 20:59:02 INFO - 'TERM': 'linux', 20:59:02 INFO - 'TMOUT': '86400', 20:59:02 INFO - 'USER': 'cltbld', 20:59:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:02 INFO - '_': '/tools/buildbot/bin/python'} 20:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:02 INFO - Running setup.py (path:/tmp/pip-ya4BHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:02 INFO - Running setup.py (path:/tmp/pip-3rzcwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:02 INFO - Running setup.py (path:/tmp/pip-_9EapS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:02 INFO - Running setup.py (path:/tmp/pip-AyEb4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:02 INFO - Running setup.py (path:/tmp/pip-ZgGzen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:02 INFO - Running setup.py (path:/tmp/pip-mZ8GCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:02 INFO - Running setup.py (path:/tmp/pip-MCpT5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:02 INFO - Running setup.py (path:/tmp/pip-5u2umk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:02 INFO - Running setup.py (path:/tmp/pip-EjPHFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:02 INFO - Running setup.py (path:/tmp/pip-H6eoV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:03 INFO - Running setup.py (path:/tmp/pip-G4vNCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:03 INFO - Running setup.py (path:/tmp/pip-SWt9xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:03 INFO - Running setup.py (path:/tmp/pip-j7QRrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:03 INFO - Running setup.py (path:/tmp/pip-PJAd7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:03 INFO - Running setup.py (path:/tmp/pip-ORQ6Ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:03 INFO - Running setup.py (path:/tmp/pip-Gr7l7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:03 INFO - Running setup.py (path:/tmp/pip-bPsMUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:59:03 INFO - Running setup.py install for manifestparser 20:59:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:59:03 INFO - Running setup.py install for mozcrash 20:59:03 INFO - Running setup.py install for mozdebug 20:59:03 INFO - Running setup.py install for mozdevice 20:59:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:59:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:59:03 INFO - Running setup.py install for mozfile 20:59:04 INFO - Running setup.py install for mozhttpd 20:59:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Running setup.py install for mozinfo 20:59:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Running setup.py install for mozInstall 20:59:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Running setup.py install for mozleak 20:59:04 INFO - Running setup.py install for mozlog 20:59:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Running setup.py install for moznetwork 20:59:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Running setup.py install for mozprocess 20:59:04 INFO - Running setup.py install for mozprofile 20:59:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:59:04 INFO - Running setup.py install for mozrunner 20:59:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Running setup.py install for mozscreenshot 20:59:05 INFO - Running setup.py install for moztest 20:59:05 INFO - Running setup.py install for mozversion 20:59:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:59:05 INFO - Cleaning up... 20:59:05 INFO - Return code: 0 20:59:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:59:05 INFO - Using env: {'DISPLAY': ':0', 20:59:05 INFO - 'HOME': '/home/cltbld', 20:59:05 INFO - 'LANG': 'en_US.UTF-8', 20:59:05 INFO - 'LANGUAGE': 'en_US:en', 20:59:05 INFO - 'LOGNAME': 'cltbld', 20:59:05 INFO - 'MAIL': '/var/mail/cltbld', 20:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:05 INFO - 'MOZ_NO_REMOTE': '1', 20:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:05 INFO - 'NO_EM_RESTART': '1', 20:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:05 INFO - 'PWD': '/builds/slave/test', 20:59:05 INFO - 'SHELL': '/bin/bash', 20:59:05 INFO - 'SHLVL': '1', 20:59:05 INFO - 'TERM': 'linux', 20:59:05 INFO - 'TMOUT': '86400', 20:59:05 INFO - 'USER': 'cltbld', 20:59:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:05 INFO - '_': '/tools/buildbot/bin/python'} 20:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:05 INFO - Running setup.py (path:/tmp/pip-4dAqup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:05 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)) 20:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:05 INFO - Running setup.py (path:/tmp/pip-7VMPaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 20:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:05 INFO - Running setup.py (path:/tmp/pip-xuobcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:05 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)) 20:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:05 INFO - Running setup.py (path:/tmp/pip-b24wN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 20:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:05 INFO - Running setup.py (path:/tmp/pip-jar8gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:05 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)) 20:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:05 INFO - Running setup.py (path:/tmp/pip-dHoU70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:05 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)) 20:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:05 INFO - Running setup.py (path:/tmp/pip-Diuu7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:06 INFO - Running setup.py (path:/tmp/pip-6nSxns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:06 INFO - Running setup.py (path:/tmp/pip-NZlWa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:06 INFO - Running setup.py (path:/tmp/pip-42nEbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:06 INFO - Running setup.py (path:/tmp/pip-xtY14U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:06 INFO - Running setup.py (path:/tmp/pip-nURSWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:06 INFO - Running setup.py (path:/tmp/pip-YganoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:06 INFO - Running setup.py (path:/tmp/pip-Vm5UKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:06 INFO - Running setup.py (path:/tmp/pip-7caNIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:06 INFO - Running setup.py (path:/tmp/pip-pzIV92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:06 INFO - Running setup.py (path:/tmp/pip-8wqIDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:06 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)) 20:59:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:59:06 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:59:06 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)) 20:59:06 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:59:06 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:59:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:59:06 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 20:59:06 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 20:59:06 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 20:59:06 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 20:59:06 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 20:59:06 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 20:59:08 INFO - Downloading blessings-1.5.1.tar.gz 20:59:08 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 20:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:59:08 INFO - Installing collected packages: blessings 20:59:08 INFO - Running setup.py install for blessings 20:59:08 INFO - Successfully installed blessings 20:59:08 INFO - Cleaning up... 20:59:08 INFO - Return code: 0 20:59:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:08 INFO - Reading from file tmpfile_stdout 20:59:08 INFO - Current package versions: 20:59:08 INFO - argparse == 1.2.1 20:59:08 INFO - blessings == 1.5.1 20:59:08 INFO - blobuploader == 1.2.4 20:59:08 INFO - docopt == 0.6.1 20:59:08 INFO - manifestparser == 1.1 20:59:08 INFO - mozInstall == 1.12 20:59:08 INFO - mozcrash == 0.16 20:59:08 INFO - mozdebug == 0.1 20:59:08 INFO - mozdevice == 0.47 20:59:08 INFO - mozfile == 1.2 20:59:08 INFO - mozhttpd == 0.7 20:59:08 INFO - mozinfo == 0.9 20:59:08 INFO - mozleak == 0.1 20:59:08 INFO - mozlog == 3.1 20:59:08 INFO - moznetwork == 0.27 20:59:08 INFO - mozprocess == 0.22 20:59:08 INFO - mozprofile == 0.28 20:59:08 INFO - mozrunner == 6.11 20:59:08 INFO - mozscreenshot == 0.1 20:59:08 INFO - mozsystemmonitor == 0.0 20:59:08 INFO - moztest == 0.7 20:59:08 INFO - mozversion == 1.4 20:59:08 INFO - psutil == 3.1.1 20:59:08 INFO - requests == 1.2.3 20:59:08 INFO - wsgiref == 0.1.2 20:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:59:08 INFO - Using env: {'DISPLAY': ':0', 20:59:08 INFO - 'HOME': '/home/cltbld', 20:59:08 INFO - 'LANG': 'en_US.UTF-8', 20:59:08 INFO - 'LANGUAGE': 'en_US:en', 20:59:08 INFO - 'LOGNAME': 'cltbld', 20:59:08 INFO - 'MAIL': '/var/mail/cltbld', 20:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:08 INFO - 'MOZ_NO_REMOTE': '1', 20:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:08 INFO - 'NO_EM_RESTART': '1', 20:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:08 INFO - 'PWD': '/builds/slave/test', 20:59:08 INFO - 'SHELL': '/bin/bash', 20:59:08 INFO - 'SHLVL': '1', 20:59:08 INFO - 'TERM': 'linux', 20:59:08 INFO - 'TMOUT': '86400', 20:59:08 INFO - 'USER': 'cltbld', 20:59:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:08 INFO - '_': '/tools/buildbot/bin/python'} 20:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 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)) 20:59:09 INFO - Cleaning up... 20:59:09 INFO - Return code: 0 20:59:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:59:09 INFO - Using env: {'DISPLAY': ':0', 20:59:09 INFO - 'HOME': '/home/cltbld', 20:59:09 INFO - 'LANG': 'en_US.UTF-8', 20:59:09 INFO - 'LANGUAGE': 'en_US:en', 20:59:09 INFO - 'LOGNAME': 'cltbld', 20:59:09 INFO - 'MAIL': '/var/mail/cltbld', 20:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:09 INFO - 'MOZ_NO_REMOTE': '1', 20:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:09 INFO - 'NO_EM_RESTART': '1', 20:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:09 INFO - 'PWD': '/builds/slave/test', 20:59:09 INFO - 'SHELL': '/bin/bash', 20:59:09 INFO - 'SHLVL': '1', 20:59:09 INFO - 'TERM': 'linux', 20:59:09 INFO - 'TMOUT': '86400', 20:59:09 INFO - 'USER': 'cltbld', 20:59:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:09 INFO - '_': '/tools/buildbot/bin/python'} 20:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:09 INFO - Downloading/unpacking jsonschema 20:59:09 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 20:59:09 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 20:59:09 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 20:59:09 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 20:59:09 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 20:59:09 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 20:59:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:59:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 20:59:11 INFO - Downloading/unpacking functools32 (from jsonschema) 20:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:11 INFO - Downloading functools32-3.2.3-2.tar.gz 20:59:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:59:11 INFO - warning: no files found matching '*.txt' 20:59:11 INFO - no previously-included directories found matching 'build' 20:59:11 INFO - no previously-included directories found matching 'dist' 20:59:11 INFO - no previously-included directories found matching '.git*' 20:59:11 INFO - Installing collected packages: jsonschema, functools32 20:59:11 INFO - Running setup.py install for functools32 20:59:11 INFO - warning: no files found matching '*.txt' 20:59:11 INFO - no previously-included directories found matching 'build' 20:59:11 INFO - no previously-included directories found matching 'dist' 20:59:11 INFO - no previously-included directories found matching '.git*' 20:59:11 INFO - Successfully installed jsonschema functools32 20:59:11 INFO - Cleaning up... 20:59:11 INFO - Return code: 0 20:59:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3911756f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, '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': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', '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 20:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8'] in /builds/slave/test/build 20:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 flake8 20:59:11 INFO - Using env: {'DISPLAY': ':0', 20:59:11 INFO - 'HOME': '/home/cltbld', 20:59:11 INFO - 'LANG': 'en_US.UTF-8', 20:59:11 INFO - 'LANGUAGE': 'en_US:en', 20:59:11 INFO - 'LOGNAME': 'cltbld', 20:59:11 INFO - 'MAIL': '/var/mail/cltbld', 20:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:11 INFO - 'MOZ_NO_REMOTE': '1', 20:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:11 INFO - 'NO_EM_RESTART': '1', 20:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:11 INFO - 'PWD': '/builds/slave/test', 20:59:11 INFO - 'SHELL': '/bin/bash', 20:59:11 INFO - 'SHLVL': '1', 20:59:11 INFO - 'TERM': 'linux', 20:59:11 INFO - 'TMOUT': '86400', 20:59:11 INFO - 'USER': 'cltbld', 20:59:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:11 INFO - '_': '/tools/buildbot/bin/python'} 20:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:11 INFO - Downloading/unpacking flake8 20:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 20:59:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 20:59:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 20:59:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:59:14 INFO - no previously-included directories found matching 'docs/_build' 20:59:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:59:14 INFO - Running setup.py install for pep8 20:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:59:14 INFO - no previously-included directories found matching 'docs/_build' 20:59:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:59:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:59:14 INFO - Cleaning up... 20:59:14 INFO - Return code: 0 20:59:14 INFO - Running post-action listener: _resource_record_post_action 20:59:14 INFO - Running post-action listener: _start_resource_monitoring 20:59:14 INFO - Starting resource monitoring. 20:59:14 INFO - ##### 20:59:14 INFO - ##### Running install step. 20:59:14 INFO - ##### 20:59:14 INFO - Running pre-action listener: _resource_record_pre_action 20:59:14 INFO - Running main action method: install 20:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:14 INFO - Reading from file tmpfile_stdout 20:59:14 INFO - Detecting whether we're running mozinstall >=1.0... 20:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:59:14 INFO - Reading from file tmpfile_stdout 20:59:14 INFO - Output received: 20:59:14 INFO - Usage: mozinstall [options] installer 20:59:14 INFO - Options: 20:59:14 INFO - -h, --help show this help message and exit 20:59:14 INFO - -d DEST, --destination=DEST 20:59:14 INFO - Directory to install application into. [default: 20:59:14 INFO - "/builds/slave/test"] 20:59:14 INFO - --app=APP Application being installed. [default: firefox] 20:59:14 INFO - mkdir: /builds/slave/test/build/application 20:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:59:30 INFO - Reading from file tmpfile_stdout 20:59:30 INFO - Output received: 20:59:30 INFO - /builds/slave/test/build/application/firefox/firefox 20:59:30 INFO - Running post-action listener: _resource_record_post_action 20:59:30 INFO - ##### 20:59:30 INFO - ##### Running run-tests step. 20:59:30 INFO - ##### 20:59:30 INFO - Running pre-action listener: _resource_record_pre_action 20:59:30 INFO - Running main action method: run_tests 20:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:59:30 INFO - Python 2.7.3 20:59:30 INFO - Return code: 0 20:59:30 INFO - grabbing minidump binary from tooltool 20:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:30 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23633d0>, '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 0x22ceed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:59:30 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 20:59:30 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 20:59:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:59:30 INFO - Return code: 0 20:59:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:59:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:59:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:59:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:59:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:59:31 INFO - Return code: 0 20:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 20:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 20:59:31 INFO - Using env: {'DISPLAY': ':0', 20:59:31 INFO - 'HOME': '/home/cltbld', 20:59:31 INFO - 'LANG': 'en_US.UTF-8', 20:59:31 INFO - 'LANGUAGE': 'en_US:en', 20:59:31 INFO - 'LOGNAME': 'cltbld', 20:59:31 INFO - 'MAIL': '/var/mail/cltbld', 20:59:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:59:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:31 INFO - 'MOZ_NO_REMOTE': '1', 20:59:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:31 INFO - 'NO_EM_RESTART': '1', 20:59:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:31 INFO - 'PWD': '/builds/slave/test', 20:59:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:59:31 INFO - 'SHELL': '/bin/bash', 20:59:31 INFO - 'SHLVL': '1', 20:59:31 INFO - 'TERM': 'linux', 20:59:31 INFO - 'TMOUT': '86400', 20:59:31 INFO - 'USER': 'cltbld', 20:59:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014', 20:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:31 INFO - '_': '/tools/buildbot/bin/python'} 20:59:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 20:59:31 INFO - mozversion application_buildid: 20160109201930 20:59:31 INFO - mozversion application_changeset: 1764c03305e60d6b9bee7308670d237ddb7767a0 20:59:31 INFO - mozversion application_display_name: Nightly 20:59:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:59:31 INFO - mozversion application_name: Firefox 20:59:31 INFO - mozversion application_remotingname: firefox 20:59:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:59:31 INFO - mozversion application_vendor: Mozilla 20:59:31 INFO - mozversion application_version: 46.0a1 20:59:31 INFO - mozversion platform_buildid: 20160109201930 20:59:31 INFO - mozversion platform_changeset: 1764c03305e60d6b9bee7308670d237ddb7767a0 20:59:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:59:31 INFO - mozversion platform_version: 46.0a1 20:59:31 INFO - using testdate: 1452401971 20:59:31 INFO - actual date: 1452401971 20:59:31 INFO - starting webserver on 'localhost:33401' 20:59:31 INFO - SUITE-START | Running 3 tests 20:59:31 INFO - TEST-START | dromaeo_css 20:59:31 INFO - operating with platform_type : linux_ 20:59:31 INFO - Initialising browser for dromaeo_css test... 20:59:31 INFO - TEST-INFO | started process 5452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJc4Qay/profile http://localhost:33401/getInfo.html) 20:59:35 INFO - PROCESS | 5452 | 20:59:35 INFO - PROCESS | 5452 | (process:5533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:59:35 INFO - PROCESS | 5452 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:59:36 INFO - PROCESS | 5452 | __metrics Screen width/height:1600/1200 20:59:36 INFO - PROCESS | 5452 | colorDepth:24 20:59:36 INFO - PROCESS | 5452 | Browser inner width/height: 1024/697 20:59:36 INFO - PROCESS | 5452 | __metrics 20:59:36 INFO - PROCESS | 5452 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:59:37 INFO - TEST-INFO | 5452: exit 0 20:59:37 INFO - Browser initialized. 20:59:37 INFO - Running cycle 1/1 for dromaeo_css test... 20:59:37 INFO - TEST-INFO | started process 5582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJc4Qay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:59:39 INFO - PROCESS | 5582 | 20:59:39 INFO - PROCESS | 5582 | (process:5638): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:59:49 INFO - PROCESS | 5582 | RSS: Main: 150667264 20:59:49 INFO - PROCESS | 5582 | 21:00:39 INFO - PROCESS | 5582 | 1452402039257 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] 21:02:51 INFO - PROCESS | 5582 | Cycle 1(1): loaded http://localhost:33401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33401/tests/dromaeo/cssquery-ext.html) 21:02:52 INFO - PROCESS | 5582 | RSS: Main: 154546176 21:02:52 INFO - PROCESS | 5582 | 21:05:54 INFO - PROCESS | 5582 | Cycle 1(1): loaded http://localhost:33401/tests/dromaeo/cssquery-ext.html (next: http://localhost:33401/tests/dromaeo/cssquery-jquery.html) 21:05:54 INFO - PROCESS | 5582 | RSS: Main: 152875008 21:05:54 INFO - PROCESS | 5582 | 21:08:56 INFO - PROCESS | 5582 | Cycle 1(1): loaded http://localhost:33401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33401/tests/dromaeo/cssquery-mootools.html) 21:08:57 INFO - PROCESS | 5582 | RSS: Main: 153305088 21:08:57 INFO - PROCESS | 5582 | 21:11:58 INFO - PROCESS | 5582 | Cycle 1(1): loaded http://localhost:33401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33401/tests/dromaeo/cssquery-prototype.html) 21:11:59 INFO - PROCESS | 5582 | RSS: Main: 152395776 21:11:59 INFO - PROCESS | 5582 | 21:15:02 INFO - PROCESS | 5582 | Cycle 1(1): loaded http://localhost:33401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33401/tests/dromaeo/cssquery-yui.html) 21:15:02 INFO - PROCESS | 5582 | RSS: Main: 153149440 21:15:02 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | Cycle 1(1): loaded http://localhost:33401/tests/dromaeo/cssquery-yui.html (next: http://localhost:33401/tests/dromaeo/cssquery-dojo.html) 21:18:05 INFO - PROCESS | 5582 | RSS: Main: 156082176 21:18:05 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | __start_tp_report 21:18:05 INFO - PROCESS | 5582 | _x_x_mozilla_page_load 21:18:05 INFO - PROCESS | 5582 | _x_x_mozilla_page_load_details 21:18:05 INFO - PROCESS | 5582 | |i|pagename|runs| 21:18:05 INFO - PROCESS | 5582 | |0;dojo.html;2636.2618466829285;2705.702372738997;2726.7273272672737;2728.6862010868745;2747.203311039798;4474.843380481684;4592.357070010197;4618.792154353054;4623.537646235375;4656.9534304656945;4506.098780243956;4539.296409056601;4589.265717485195;4641.559051890065;4656.534346565341;4252.425922500469;4265.893352666177;4323.632491238232;4338.826446942118;4383.495897971727;4278.679099067567;4319.460067491564;4321.783910804447;4354.7604881731495;4369.6285815705705;4176.498820141572;4216.9156616867795;4262.424572682679;4271.444712187395;4288.892777680536;4207.558206388347;4211.05251318454;4219.641330486912;4219.9578004219875;4236.131593023423;4135.710500264982;4184.832606695729;4189.8477918572335;4190.455240818705;4194.517630472474;4383.583559561836;4442.53353397895;4487.080148569536;4513.413256276696;4560.429946256718;4874.902501949941;4880.731559764212;4886.218205087169;4895.069936712049;4901.509849015106;4903.53416425439;4909.8772530686665;4911.901761964777;4916.287138364917;4918.557329840296;4570.771461426949;4627.976860115745;4629.953700463019;4631.235846085358;4678.859634210945;5049.495050494921;5051.318072060299;5051.545360917535;5062.924056139161;5076.035553244872;4769.928451073237;4819.807207711652;4831.541003604652;4847.418309802846;4889.4377146627885;4961.627877909099;4963.205887058053;4970.8757281068265;4989.201727723546;4997.775100120503;4887.560119589183;4925.38432695913;4931.605471562267;4936.48166942473;4967.627427942919;4750.714957102585;4768.594669453136;4798.47216806151;4904.117258893362;4935.531124543163;4149.2738770715005;4154.127633197002;4158.91682166355;4159.10579225468;4178.791060446965;3657.6890964267805;3666.6699997000396;3673.8897833065053;3702.2225332680437;3704.111013356829;4141.544430112685;4240.406343111967;4245.957540424618;4306.763128027926;4324.78376081201;4955.405351357788;4979.875503112378;4981.726005069683;4986.077575648516;5029.094762942632;4134.111166099303;4294.312909934395;4296.205202037633;4298.226319262562;4332.6317263033;4326.480822301344;4351.26028575143;4385.736855788663;4389.780510974439;4420.7126536775;4749.715017098985;4755.95244047562;4758.619310455225;4758.881027974328;4772.689775164603;4813.446453657734;4931.0877487663465;5028.1200789860895;5048.343715316985;5072.416672082758;4687.414073240845;4708.152532544175;4731.716097034189;4768.66619336657;4825.469198388245;4856.708597484162;4885.5358740919555;4894.779734911866;4900.068986892479;4931.13705101613;4835.6131509478455;4975.825846095369;4980.825671101494;4985.501449855131;5036.722980235975;4755.167845627071;4778.426588809365;4812.35033270504;4823.5658790709;4875.219964805614;4836.685615434985;4843.660943733905;4865.172920603435;4895.8041678332465;4908.730019848943;4526.072155208109;4675.742834144155;4778.904421911473;4789.3055506952;4857.635677324144;4824.0834241494;4909.4845041270155;4912.631552633496;4919.458859525521;4957.752112394293;4736.8578942631775;4761;4781.187198176388;4789.640776941674;4805.639577031667 21:18:05 INFO - PROCESS | 5582 | |1;ext.html;483.66627027351126;491.1674711364239;494.44375078037206;497.1895809829974;513.7387713164183;24905.252842414735;32445;32647.51028734565;32796.67203327969;32846.83576582114;35752.10619734508;36131.4580281296;36258;36495.08762280944;36522.452163217575;7460.776176714694;7810.921890781105;7816.335611473031;7823.491473054261;7824.647890844925;7714.112877019131;7924.128345881948;7941.722039728611;7957.840843183162;7961.800954976114;7913.129555748863;7972.5216487010675;8019.639116239783;8021.157778433268;8022.1576734442915;7852.528848269122;7915.762527124196;7955;7977.960110199441;7980.4812687175145;7738.342240909529;7834.725784597512;7859.174786647377;7881.960590197013;7885.605719714049;36818.447723284175;37293.44059839105;37348.62651373479;37363.626363736286;37415.62584374149;2805.6212411324414;2967.6735559088484;3037.5747395364665;3138.2625083105454;3363.7981721096567;28195.154145375673;28370.876268072414;28766.137015889555;28902.855485722437;29195.270118247;3278.918027049319;3327.6505966873615;3338.599368075822;3348.3303339331987;3398.762086653935;212921;212975;213286;214508;215478;46179.99999999933;47156.292655610196;54120.72939635276;54742.452575474534;54792.17811732827;57944.71027644835;58864.411355885895;59083.40916590779;59202.70398648065;59255.40744592585;13930.86069139316;13945.442182312594;13984.160950343012;14036;14141.5050473235;11368;11401.144914131473;11485.712857178638;11490.368029758443;11491.885081149248;17965.550861228312;18091.185896634684;18259.72610410845;18819.153138108817;19071.332503362315;7079.6371723431985;7382.667779949915;7388.963055184797;7394.704211831574;7453.590052547162;822.6339279020779;828.5235989306173;888.5823662878437;902.869083982832;936.8969413364524;25630.74369256321;26100.477990440086;26271.737282627313;26624.60063099055;27027.324316892234;897.1521911793293;902.4900930973979;941.087145468894;944.3955868244329;1013.4223492609142;12557.686057848627;12581;12652.81020784689;12785.936070319589;12802.487900484062;255016;258482;259617;260832.08751868736;260941;45202.547974520494;45571.54428455673;45619;45622.31566526505;45721.77139114283;1198.6344165029575;1217.5373358124034;1226.497136174182;1244.3902487780922;1251;24568.38579035467;24571.38571535726;24950.126745564543;25221.621675674513;25566.10518631839;40331.79834100928;40836;41066.1786764269;41131;41206.793966029974;237299;238957;239559;239603;239707;27946;28714.282142945758;29192.27019324534;29291.41417171687;29365.853170734863;33337;33744.49383259302;34099;34332.656673432946;34415.65584344124;31080.378392432478;31334.373312534077;31923.84038079795;32018.839905800323;32279.35441291208;31758.36483270368;31934;32047.679523204468;32225.51661725123;32354.191145221557;31625.8418707905;31790.52314215335;31937.361252775278;32135;32137;27749.583756244076;28947.131586052452;29748.702512974593;29829;30415.087547373616;21587.35237942864;23681.17115900935;25390;25584.915841064674;25586.61620075663 21:18:05 INFO - PROCESS | 5582 | |2;jquery.html;316.4272666473683;316.6058257469448;319.2147317598707;321.12173206280835;331.7710779562102;14242.074265172769;14752.262386880653;14838;14976.625584360369;15692;9586.568604412802;9859.802803943916;11554.53781848725;14410.711785764279;14471.131732096082;4297.527272000078;4362.25841606926;4516.954830451687;4551.590356867881;4574.97712511437;4418.204723149832;4559.156556037127;4562.270036794113;4563.726176429408;4565.977170114144;3423.5035919791617;4564.566366195206;4574.519675434081;4760.952390476085;5133.922991155136;5062.265971434122;5078.466760990117;5102.132637451642;5102.413222479407;5107.61692873036;4856.927146092776;5150.175971844525;5155.871103222412;5161.845144645667;5169;11291.830622540669;11367;11633.70915727105;13614.842738367252;18070.09649517519;1788.1416919878402;1793.2557988434785;1816.4369045595909;1881.1628825172804;1891.0166713309002;8342.457740246926;8441.535715535643;8543.102974187745;8642.783930401727;8717.564121793948;340.8023346459048;340.9974674457113;1574.4804214609267;1636.9754453683204;1718.3708925344242;43941;46746.298805517945;47174.76412617949;48616.75691621519;54268.457315426735;9279.211267042241;9650.324477286664;9852.802943941224;9856.50717464124;9916.950415247878;12343.382830858422;12386.442610082388;12423.130380873252;12431.37843107841;12443.813342799865;7311.341979221896;7311.744088956861;7362.8527429451115;7372.557646541225;7397.778066658009;7002.054722612382;7025.648717564101;7051.1186101737285;7055.89416158758;7091.787246382617;3875.8062096895605;3917.2948869203815;4200;4236.301010333261;4273.081287523135;1607.1401800036924;1648.365379328967;1702.7956645202407;1710.9743353849701;1756.2799252306493;735.492510167993;848.1010129263001;905.3933864310927;929.41158872541;943.4763706143157;14865.256737163314;14935.402583896739;14957.252137393087;15101.848981510264;15346.15596142223;763.9159692433827;814.3973459639942;861.2291998661289;900.6712549919363;930.3812964378612;8745.47527148373;8755.343349248704;8776.561171941377;8781.51701656415;9052.954735226282;439191;449124;452227;453156;453477;63639.72720545563;65204.347956520774;65261;65288;66386.33613663899;1054.2725519391595;1099.71957150926;1108.3793075877534;1112.6828853776797;1117.8323251512338;13127.934360328138;13369.732605348034;13505.797413038616;13533.120347177402;13845.584632461043;27901.302467438476;28374.716252837206;28691.569626455203;28850.134495965154;28900.566491502224;36568.26863462769;36628.45057324196;37336.813315934334;38013.61986380101;41960.79019604882;6417.454516366161;6679.9332006679315;6815.829604259933;6890.896636550556;6968.407685346802;8385.95807020961;9668.888077870854;9836.114749672564;9865.950670246602;10455.215858810467;7615.02431814325;8463.49219046859;8649.264812490757;8817.206451419403;8921.509316987627;8894.735006452196;9109.453432794053;9379.202767764817;9726.465044422624;9771.511424428892;7764.029496312961;8620.181082797124;8874.112588741074;8895.955520222358;9220.861687074565;6107.297660768891;6260.780872669435;6289.49684025286;6399.520035997226;6813.04617353561;6686;8193.67225310981;8260.463069900437;8301.792455188426;8366.581670916308 21:18:05 INFO - PROCESS | 5582 | |3;mootools.html;1383.7440073586388;1394.9163050216987;1525.5652139140348;1715.416758302177;1730.3597668862524;6102.17620621216;6250.749970001206;7168.354848063674;7294.671739771709;7382.372498337648;7165.283471652845;7304.890426643605;7371.37343325818;7399.926000739991;7463.738769143068;2168.1869299012833;2197.13213280754;2197.48359135603;2197.8351623628214;2200.3508964855328;2132.2217390652454;2167.5989941860807;2209.5359974405396;2231.966520502194;2235.7428895677044;2188.5622875424897;2197.165077270635;2209.9889500552476;2210.6573481110454;2220.666899965002;2097.81119699227;2105.3262955854134;2110.7150534677776;2111.1133324003877;2117.9682304765442;2154.332157031325;2193.1665966932624;2195.6047911375945;2200.262911924507;2201.020545857094;7495.625218739041;7512;7548.358389536841;7549.433792465532;7560.924390756077;4345.044090300129;4465.531119232466;4471.016376397188;4487.6634252431195;4490.3488994096;2909.3890283040587;2949.1594895454905;2978.9851050744824;2990.476666583339;2994.6406431228174;928.3594319919234;957.6504575829772;963.8843338799389;981.842905135182;989.5794287427815;10258.743531411774;10309.484525773682;10311;10313.845292320697;10324.380537167719;4039.4546736190237;4054.128362402039;4069.613386728256;4115.855945041969;4120.690948178899;8798.164174403422;8863.512506812058;8864.290856731446;8868.246199073152;8887.600057997406;4392.5607439256455;4395.362672412482;4403.207422663887;4418.756968366706;4432.29083346663;3359.8488068036995;3446.069561218457;3911.6870650347905;3971.146203566247;3987.860424885115;3551.9112022199133;3589.2283159120393;3613.855445782139;3619.221867298491;3624.9637503624626;1169.3159501691437;1171.4377098992532;1174.236746115032;1183.556166437586;1188.5245901639241;912.9315301352425;923.1460898668705;931.5016466190556;945.8817647794026;1202.0323639470137;6499.805005849832;6501.44737697301;6538.476921846241;6553.148090748172;6563.7702680405955;443.39698010705416;444.7242709520118;446.55790767140945;449.4247363374885;455.574038274208;5436.510714035677;5496.5053145217125;5499;5507.311586051744;5542.11326187808;8353.498790072616;8778.868316975251;8821.823563528693;8850.822983540293;8911;8635.266002389868;8654.134586541295;8686;8700.216980471661;8713.390062695551;6860.588364698134;6915.377616014583;7033.156021277479;7071.858562828715;7173.246809085075;6589.80230593083;6627.1716035495565;6637.203535575762;6640.402363787282;6647.335266473314;7555.622218889143;7843.333316668147;7892.329152022143;7895.249951254622;8013.879791803244;7990.720324788605;8276.917230827614;8294.336453083619;8385.790355241168;8399.580020998803;5202.427732949448;6157.230346206724;6161.876762464636;6189.669221117481;6358.682065896594;6830.897536537055;7005.824854378681;7029.859402811813;7032.331928466788;7047.330503602149;6570.5729127606555;6605.339466053356;6654;6754.088198093391;6840.3501667341525;6513.478921686348;6530.47756179514;6676.365745254193;6740.62926539045;6802.489813263926;6487.1566696331065;6561.80314590563;6572.76995305162;6573.704183311858;6583.703733331916;6066.939330606638;6084.361142080195;6111;6164.907526387018;6174.104754810617;6026.276846778414;6100.298465676504;6100.938990610037;6102.603330783485;6104.4200800923845 21:18:05 INFO - PROCESS | 5582 | |4;prototype.html;300.2628546917318;309.21151064784806;310.37149771712274;316.0376653091338;318.0728177362987;5444.754986025629;5454.781808727651;5586.86032849179;5591.860203494904;5633.408492108326;5408.323959505062;5521.972390138044;5540.141278101891;5542.8337149885465;5553.72231388431;4310.461192350964;4316.503602085769;4317.848875289365;4320.049589090395;4325.394444777734;4302.913941721164;4307.633851122659;4310.547392523787;4311.051568654907;4312.525622181557;4057.2494088593558;4185.121124563845;4274.636655884238;4308.504521979966;4311.3748506466545;4188.287991041515;4198.307279298912;4224.281872081753;4228.577142285747;4232.32282834748;3688.0779805048737;3693.279810436966;3695.3533131701843;3699.223163135745;3702.7222958277966;5260.473952604747;5367.516923476866;5372.892542149174;5379.273798037254;5381.9461805382225;4858.344123543312;4880.902381952376;4885.071836351118;4890.24201248807;4893.168161412568;5812.157237200625;5834.183214349994;5842.620229685057;5847.8245652630485;5853.5317174625925;3874.341361968444;4015.578364271739;4016.6987475939422;4026.59734026595;4033.4353190553347;6022.6687532185715;6109.816705498843;6124.7243874025335;6129.356417576179;6131.816045518686;4133.0700592366475;4135.400366946836;4135.524414692349;4136.627703506699;4145.0880806222585;4195.098053918422;4197.4753155855515;4200.7479551227025;4203.117345357448;4210.200061988213;4718.386609740781;4820.3492528508905;4824.541668541483;4828.227483602677;4830.492798256132;5808.6224395414165;5810.389909059488;5814.215080964016;5815.82552523425;5821.446962538552;1473.5579326202096;1494.1707352419512;1494.7010597880467;1494.7907292978773;1496.416397604913;996.8006398720285;1006.0693858181153;1008.3899240959114;1011.6610935336745;1025.5795123999123;5033.723145226974;5040.697558146449;5057.570106540912;5062.367204099488;5063.291139240509;6070.635761854214;6072.878542429126;6075.544334174954;6078.45293923549;6087.54343424245;5013.147764879906;5018.447970723218;5019.598432125421;5049.722265275372;5054.418741844662;3207.1661368044474;3265.689759472846;3272.640009598942;3287.1946373138735;3296.3736889990823;5601.495865372054;5716.5140963017775;5725.570582206351;5726.055200891889;5732.426757324234;6265.216847894013;6286.4342209201395;6293.433590976834;6293.653849038347;6293.748250070037;5789.594728369058;5793.681347525842;5841.649501029951;5848.53211743051;5852.473277404969;6117;6124.050772130327;6143.385661433821;6146.6004709693725;6148.077788331786;5830.18377427169;5906.763729450774;5909.940900590939;5911.881762364643;5918.556108291809;5725.971370143123;5769.942300577109;5790;5791;5803.506701930214;4249.426327445879;4297.957020429756;4299.935500967551;4303.612674859278;4306.138772245501;5928;6021.578489505868;6039.939600603938;6048.213732214784;6048.788292409745;5817.2146760188525;5818.040023396262;5823.854403639943;5827.038538641077;5827.621204621686;5815.302163740378;5822.912656310244;5828.2423284974375;5850.0932355484965;5893.057110862242;5582.0789569722165;5695.857603559944;5699.373068962494;5712.971435142797;5727.11229759388;5820.912686309794;5829.417058294306;5840.737166827418;5848.181254624441;5857.384974577779;5632.5493960482245;5639.407862174413;5646.548276137817;5678.716064196691;5682.5453963681975 21:18:05 INFO - PROCESS | 5582 | |5;yui.html;748.5920173505439;762.7254188492142;772.7720322504861;780.9492382995109;788.2432864450128;10641.680749577516;10744.838827417596;10766.892331076688;10772.245942784008;10772.838407423895;10473.633422830202;10565.260431769779;10597.682069537927;10602.204834637394;10604.363738175714;584.7660935625762;606.3936063936064;755.6486233901221;758.321302434321;764.644440335244;746.2090184404522;752.8607207666572;753.2053683364048;758.8065043413922;761.958092304923;807.7172989453703;807.7818988873;807.9798005049862;808.5431731071955;811.9106898241189;799.6161842315692;799.952002879829;801.9198080191934;806.3267171911461;807.4953154278576;594.3729365519375;598.317917573966;598.5241732822417;599.0176111177672;601.5788947736602;11498.942505287503;11564.768704625945;11604.30374177552;11615.767684646344;11640.126990475748;11889.881101188965;11959.162858599902;12015;12144.817827732591;12228.266304021787;9181.81636367269;9420.340576159671;9485.241180705527;9505.809883802354;9591.856122158173;3932.9803350983348;3986.80065996699;4016.116454380032;4125.566815484361;4148.709590328678;36103.81948090269;36151.09622259438;36347.63652363495;36546;36646;8889;9015.14356136166;9256.861147082664;9308.581113849894;9387.859182112274;15210.391584336503;15796.763048554281;15820.604484887739;15830.920845395929;15831.683366332609;6053.697315134225;6103.786367477117;6162.352952939877;6213.720382582795;6236.563440559208;3576.964230357715;3634.7819130852236;3637.7999210043704;3647.106458917582;3696.1868388954385;2618.16218809979;2632.0129951268273;2632.3813903732607;2641.181233817484;2643.828151170168;489.8334566247493;499.88002879308704;500.46450298181327;500.76213798446173;505.4945054945055;436.16474451425165;475.96668233224034;490.8527441767527;520.1729250491736;541.7643325153571;7117.6085315308155;7165.283471652897;7225.096862892138;7311.744088956861;8339.12439193888;459.7264627546604;482.92031814750874;539.5764325004852;592.4194289596134;627.66106302597;3351.5307856899567;3525.9471107932886;3564.1802385450974;3590.5225394477725;3618.9095272618397;45289;45476.3178552322;45647;45736.542634573896;46004.309935351;42493.787531062146;42966.35550466745;43340.78329608332;43476.130477390274;43654;38011.80994095067;38217;38233.23533529314;39433.60566394357;40005.19989600192;7858.057033155829;8041.557714325768;8062.072861620989;8140.267375936194;8198.38512111606;30501.389972199988;30913.8454307727;31052.689473105882;31629.209269767518;31712.682873170972;34884.47673284852;35435.291294173454;37315;39284.6071539281;39392.60607394004;9812.26408019387;10291.33106348085;10375.118114960313;10431;10646.414447205478;10620.582245118167;10665.485263152483;10686.358818470917;10693.9465302673;10839.837402438812;10193;10206.030427109412;10215.489225538842;10216.489175541343;10275.588976440858;9594.904050959402;9627.326087173831;9645.131938125602;9645.662401815904;9656.082672146134;9767.511624418892;9889.604415823287;9910.554025068745;9976.551055202679;9982.101610854768;7748.535087894745;8038.236367545074;8039.115697273179;8182.631781569963;8236.629351679308;8656.26421754158;8850.822983540163;8871.911280887109;8908.688195913111;8960.103989600988 21:18:05 INFO - PROCESS | 5582 | __end_tp_report 21:18:05 INFO - PROCESS | 5582 | __start_cc_report 21:18:05 INFO - PROCESS | 5582 | _x_x_mozilla_cycle_collect,355 21:18:05 INFO - PROCESS | 5582 | __end_cc_report 21:18:05 INFO - PROCESS | 5582 | __startTimestamp1452403085529__endTimestamp 21:18:05 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | ------- Summary: start ------- 21:18:05 INFO - PROCESS | 5582 | Number of tests: 6 21:18:05 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | [#0] dojo.html Cycles:165 Average:4571.28 Median:4750.71 stddev:466.00 (9.8%) stddev-sans-first:442.02 21:18:05 INFO - PROCESS | 5582 | Values: 2636.3 2705.7 2726.7 2728.7 2747.2 4474.8 4592.4 4618.8 4623.5 4657.0 4506.1 4539.3 4589.3 4641.6 4656.5 4252.4 4265.9 4323.6 4338.8 4383.5 4278.7 4319.5 4321.8 4354.8 4369.6 4176.5 4216.9 4262.4 4271.4 4288.9 4207.6 4211.1 4219.6 4220.0 4236.1 4135.7 4184.8 4189.8 4190.5 4194.5 4383.6 4442.5 4487.1 4513.4 4560.4 4874.9 4880.7 4886.2 4895.1 4901.5 4903.5 4909.9 4911.9 4916.3 4918.6 4570.8 4628.0 4630.0 4631.2 4678.9 5049.5 5051.3 5051.5 5062.9 5076.0 4769.9 4819.8 4831.5 4847.4 4889.4 4961.6 4963.2 4970.9 4989.2 4997.8 4887.6 4925.4 4931.6 4936.5 4967.6 4750.7 4768.6 4798.5 4904.1 4935.5 4149.3 4154.1 4158.9 4159.1 4178.8 3657.7 3666.7 3673.9 3702.2 3704.1 4141.5 4240.4 4246.0 4306.8 4324.8 4955.4 4979.9 4981.7 4986.1 5029.1 4134.1 4294.3 4296.2 4298.2 4332.6 4326.5 4351.3 4385.7 4389.8 4420.7 4749.7 4756.0 4758.6 4758.9 4772.7 4813.4 4931.1 5028.1 5048.3 5072.4 4687.4 4708.2 4731.7 4768.7 4825.5 4856.7 4885.5 4894.8 4900.1 4931.1 4835.6 4975.8 4980.8 4985.5 5036.7 4755.2 4778.4 4812.4 4823.6 4875.2 4836.7 4843.7 4865.2 4895.8 4908.7 4526.1 4675.7 4778.9 4789.3 4857.6 4824.1 4909.5 4912.6 4919.5 4957.8 4736.9 4761.0 4781.2 4789.6 4805.6 21:18:05 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | [#1] ext.html Cycles:180 Average:39409.47 Median:32399.60 stddev:61958.80 (191.2%) stddev-sans-first:62063.67 21:18:05 INFO - PROCESS | 5582 | Values: 483.7 491.2 494.4 497.2 513.7 24905.3 32445.0 32647.5 32796.7 32846.8 35752.1 36131.5 36258.0 36495.1 36522.5 7460.8 7810.9 7816.3 7823.5 7824.6 7714.1 7924.1 7941.7 7957.8 7961.8 7913.1 7972.5 8019.6 8021.2 8022.2 7852.5 7915.8 7955.0 7978.0 7980.5 7738.3 7834.7 7859.2 7882.0 7885.6 36818.4 37293.4 37348.6 37363.6 37415.6 2805.6 2967.7 3037.6 3138.3 3363.8 28195.2 28370.9 28766.1 28902.9 29195.3 3278.9 3327.7 3338.6 3348.3 3398.8 212921.0 212975.0 213286.0 214508.0 215478.0 46180.0 47156.3 54120.7 54742.5 54792.2 57944.7 58864.4 59083.4 59202.7 59255.4 13930.9 13945.4 13984.2 14036.0 14141.5 11368.0 11401.1 11485.7 11490.4 11491.9 17965.6 18091.2 18259.7 18819.2 19071.3 7079.6 7382.7 7389.0 7394.7 7453.6 822.6 828.5 888.6 902.9 936.9 25630.7 26100.5 26271.7 26624.6 27027.3 897.2 902.5 941.1 944.4 1013.4 12557.7 12581.0 12652.8 12785.9 12802.5 255016.0 258482.0 259617.0 260832.1 260941.0 45202.5 45571.5 45619.0 45622.3 45721.8 1198.6 1217.5 1226.5 1244.4 1251.0 24568.4 24571.4 24950.1 25221.6 25566.1 40331.8 40836.0 41066.2 41131.0 41206.8 237299.0 238957.0 239559.0 239603.0 239707.0 27946.0 28714.3 29192.3 29291.4 29365.9 33337.0 33744.5 34099.0 34332.7 34415.7 31080.4 31334.4 31923.8 32018.8 32279.4 31758.4 31934.0 32047.7 32225.5 32354.2 31625.8 31790.5 31937.4 32135.0 32137.0 27749.6 28947.1 29748.7 29829.0 30415.1 21587.4 23681.2 25390.0 25584.9 25586.6 21:18:05 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | [#2] jquery.html Cycles:180 Average:23463.59 Median:4808.94 stddev:73448.41 (1527.3%) stddev-sans-first:73633.89 21:18:05 INFO - PROCESS | 5582 | Values: 316.4 316.6 319.2 321.1 331.8 14242.1 14752.3 14838.0 14976.6 15692.0 9586.6 9859.8 11554.5 14410.7 14471.1 4297.5 4362.3 4517.0 4551.6 4575.0 4418.2 4559.2 4562.3 4563.7 4566.0 3423.5 4564.6 4574.5 4761.0 5133.9 5062.3 5078.5 5102.1 5102.4 5107.6 4856.9 5150.2 5155.9 5161.8 5169.0 11291.8 11367.0 11633.7 13614.8 18070.1 1788.1 1793.3 1816.4 1881.2 1891.0 8342.5 8441.5 8543.1 8642.8 8717.6 340.8 341.0 1574.5 1637.0 1718.4 43941.0 46746.3 47174.8 48616.8 54268.5 9279.2 9650.3 9852.8 9856.5 9917.0 12343.4 12386.4 12423.1 12431.4 12443.8 7311.3 7311.7 7362.9 7372.6 7397.8 7002.1 7025.6 7051.1 7055.9 7091.8 3875.8 3917.3 4200.0 4236.3 4273.1 1607.1 1648.4 1702.8 1711.0 1756.3 735.5 848.1 905.4 929.4 943.5 14865.3 14935.4 14957.3 15101.8 15346.2 763.9 814.4 861.2 900.7 930.4 8745.5 8755.3 8776.6 8781.5 9053.0 439191.0 449124.0 452227.0 453156.0 453477.0 63639.7 65204.3 65261.0 65288.0 66386.3 1054.3 1099.7 1108.4 1112.7 1117.8 13127.9 13369.7 13505.8 13533.1 13845.6 27901.3 28374.7 28691.6 28850.1 28900.6 36568.3 36628.5 37336.8 38013.6 41960.8 6417.5 6679.9 6815.8 6890.9 6968.4 8386.0 9668.9 9836.1 9866.0 10455.2 7615.0 8463.5 8649.3 8817.2 8921.5 8894.7 9109.5 9379.2 9726.5 9771.5 7764.0 8620.2 8874.1 8896.0 9220.9 6107.3 6260.8 6289.5 6399.5 6813.0 6686.0 8193.7 8260.5 8301.8 8366.6 21:18:05 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | [#3] mootools.html Cycles:180 Average:5123.01 Median:6134.12 stddev:2685.28 (43.8%) stddev-sans-first:2678.10 21:18:05 INFO - PROCESS | 5582 | Values: 1383.7 1394.9 1525.6 1715.4 1730.4 6102.2 6250.7 7168.4 7294.7 7382.4 7165.3 7304.9 7371.4 7399.9 7463.7 2168.2 2197.1 2197.5 2197.8 2200.4 2132.2 2167.6 2209.5 2232.0 2235.7 2188.6 2197.2 2210.0 2210.7 2220.7 2097.8 2105.3 2110.7 2111.1 2118.0 2154.3 2193.2 2195.6 2200.3 2201.0 7495.6 7512.0 7548.4 7549.4 7560.9 4345.0 4465.5 4471.0 4487.7 4490.3 2909.4 2949.2 2979.0 2990.5 2994.6 928.4 957.7 963.9 981.8 989.6 10258.7 10309.5 10311.0 10313.8 10324.4 4039.5 4054.1 4069.6 4115.9 4120.7 8798.2 8863.5 8864.3 8868.2 8887.6 4392.6 4395.4 4403.2 4418.8 4432.3 3359.8 3446.1 3911.7 3971.1 3987.9 3551.9 3589.2 3613.9 3619.2 3625.0 1169.3 1171.4 1174.2 1183.6 1188.5 912.9 923.1 931.5 945.9 1202.0 6499.8 6501.4 6538.5 6553.1 6563.8 443.4 444.7 446.6 449.4 455.6 5436.5 5496.5 5499.0 5507.3 5542.1 8353.5 8778.9 8821.8 8850.8 8911.0 8635.3 8654.1 8686.0 8700.2 8713.4 6860.6 6915.4 7033.2 7071.9 7173.2 6589.8 6627.2 6637.2 6640.4 6647.3 7555.6 7843.3 7892.3 7895.2 8013.9 7990.7 8276.9 8294.3 8385.8 8399.6 5202.4 6157.2 6161.9 6189.7 6358.7 6830.9 7005.8 7029.9 7032.3 7047.3 6570.6 6605.3 6654.0 6754.1 6840.4 6513.5 6530.5 6676.4 6740.6 6802.5 6487.2 6561.8 6572.8 6573.7 6583.7 6066.9 6084.4 6111.0 6164.9 6174.1 6026.3 6100.3 6100.9 6102.6 6104.4 21:18:05 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | [#4] prototype.html Cycles:180 Average:4832.07 Median:5449.77 stddev:1428.37 (26.2%) stddev-sans-first:1391.28 21:18:05 INFO - PROCESS | 5582 | Values: 300.3 309.2 310.4 316.0 318.1 5444.8 5454.8 5586.9 5591.9 5633.4 5408.3 5522.0 5540.1 5542.8 5553.7 4310.5 4316.5 4317.8 4320.0 4325.4 4302.9 4307.6 4310.5 4311.1 4312.5 4057.2 4185.1 4274.6 4308.5 4311.4 4188.3 4198.3 4224.3 4228.6 4232.3 3688.1 3693.3 3695.4 3699.2 3702.7 5260.5 5367.5 5372.9 5379.3 5381.9 4858.3 4880.9 4885.1 4890.2 4893.2 5812.2 5834.2 5842.6 5847.8 5853.5 3874.3 4015.6 4016.7 4026.6 4033.4 6022.7 6109.8 6124.7 6129.4 6131.8 4133.1 4135.4 4135.5 4136.6 4145.1 4195.1 4197.5 4200.7 4203.1 4210.2 4718.4 4820.3 4824.5 4828.2 4830.5 5808.6 5810.4 5814.2 5815.8 5821.4 1473.6 1494.2 1494.7 1494.8 1496.4 996.8 1006.1 1008.4 1011.7 1025.6 5033.7 5040.7 5057.6 5062.4 5063.3 6070.6 6072.9 6075.5 6078.5 6087.5 5013.1 5018.4 5019.6 5049.7 5054.4 3207.2 3265.7 3272.6 3287.2 3296.4 5601.5 5716.5 5725.6 5726.1 5732.4 6265.2 6286.4 6293.4 6293.7 6293.7 5789.6 5793.7 5841.6 5848.5 5852.5 6117.0 6124.1 6143.4 6146.6 6148.1 5830.2 5906.8 5909.9 5911.9 5918.6 5726.0 5769.9 5790.0 5791.0 5803.5 4249.4 4298.0 4299.9 4303.6 4306.1 5928.0 6021.6 6039.9 6048.2 6048.8 5817.2 5818.0 5823.9 5827.0 5827.6 5815.3 5822.9 5828.2 5850.1 5893.1 5582.1 5695.9 5699.4 5713.0 5727.1 5820.9 5829.4 5840.7 5848.2 5857.4 5632.5 5639.4 5646.5 5678.7 5682.5 21:18:05 INFO - PROCESS | 5582 | 21:18:05 INFO - PROCESS | 5582 | [#5] yui.html Cycles:180 Average:11687.53 Median:23240.14 stddev:12963.96 (55.8%) stddev-sans-first:12974.30 21:18:05 INFO - PROCESS | 5582 | Values: 748.6 762.7 772.8 780.9 788.2 10641.7 10744.8 10766.9 10772.2 10772.8 10473.6 10565.3 10597.7 10602.2 10604.4 584.8 606.4 755.6 758.3 764.6 746.2 752.9 753.2 758.8 762.0 807.7 807.8 808.0 808.5 811.9 799.6 800.0 801.9 806.3 807.5 594.4 598.3 598.5 599.0 601.6 11498.9 11564.8 11604.3 11615.8 11640.1 11889.9 11959.2 12015.0 12144.8 12228.3 9181.8 9420.3 9485.2 9505.8 9591.9 3933.0 3986.8 4016.1 4125.6 4148.7 36103.8 36151.1 36347.6 36546.0 36646.0 8889.0 9015.1 9256.9 9308.6 9387.9 15210.4 15796.8 15820.6 15830.9 15831.7 6053.7 6103.8 6162.4 6213.7 6236.6 3577.0 3634.8 3637.8 3647.1 3696.2 2618.2 2632.0 2632.4 2641.2 2643.8 489.8 499.9 500.5 500.8 505.5 436.2 476.0 490.9 520.2 541.8 7117.6 7165.3 7225.1 7311.7 8339.1 459.7 482.9 539.6 592.4 627.7 3351.5 3525.9 3564.2 3590.5 3618.9 45289.0 45476.3 45647.0 45736.5 46004.3 42493.8 42966.4 43340.8 43476.1 43654.0 38011.8 38217.0 38233.2 39433.6 40005.2 7858.1 8041.6 8062.1 8140.3 8198.4 30501.4 30913.8 31052.7 31629.2 31712.7 34884.5 35435.3 37315.0 39284.6 39392.6 9812.3 10291.3 10375.1 10431.0 10646.4 10620.6 10665.5 10686.4 10693.9 10839.8 10193.0 10206.0 10215.5 10216.5 10275.6 9594.9 9627.3 9645.1 9645.7 9656.1 9767.5 9889.6 9910.6 9976.6 9982.1 7748.5 8038.2 8039.1 8182.6 8236.6 8656.3 8850.8 8871.9 8908.7 8960.1 21:18:05 INFO - PROCESS | 5582 | -------- Summary: end -------- 21:18:05 INFO - PROCESS | 5582 | 21:18:06 INFO - TEST-INFO | 5582: exit 0 21:18:06 INFO - TEST-OK | dromaeo_css | took 1114645ms 21:18:06 INFO - TEST-START | kraken 21:18:06 INFO - operating with platform_type : linux_ 21:18:06 INFO - Initialising browser for kraken test... 21:18:06 INFO - TEST-INFO | started process 5821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU8RTdE/profile http://localhost:33401/getInfo.html) 21:18:09 INFO - PROCESS | 5821 | 21:18:09 INFO - PROCESS | 5821 | (process:5891): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:18:10 INFO - PROCESS | 5821 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 21:18:10 INFO - PROCESS | 5821 | __metrics Screen width/height:1600/1200 21:18:10 INFO - PROCESS | 5821 | colorDepth:24 21:18:10 INFO - PROCESS | 5821 | Browser inner width/height: 1024/697 21:18:10 INFO - PROCESS | 5821 | __metrics 21:18:10 INFO - PROCESS | 5821 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:18:11 INFO - TEST-INFO | 5821: exit 0 21:18:11 INFO - Browser initialized. 21:18:11 INFO - Running cycle 1/1 for kraken test... 21:18:11 INFO - TEST-INFO | started process 5940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU8RTdE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:13 INFO - PROCESS | 5940 | 21:18:13 INFO - PROCESS | 5940 | (process:5996): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:18:23 INFO - PROCESS | 5940 | RSS: Main: 150339584 21:18:23 INFO - PROCESS | 5940 | 21:18:26 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33401/tests/kraken/driver.html?testName=audio-beat-detection) 21:18:27 INFO - PROCESS | 5940 | RSS: Main: 152088576 21:18:27 INFO - PROCESS | 5940 | 21:18:29 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33401/tests/kraken/driver.html?testName=audio-dft) 21:18:30 INFO - PROCESS | 5940 | RSS: Main: 152485888 21:18:30 INFO - PROCESS | 5940 | 21:18:33 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33401/tests/kraken/driver.html?testName=audio-fft) 21:18:33 INFO - PROCESS | 5940 | RSS: Main: 146440192 21:18:33 INFO - PROCESS | 5940 | 21:18:35 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33401/tests/kraken/driver.html?testName=audio-oscillator) 21:18:36 INFO - PROCESS | 5940 | RSS: Main: 147468288 21:18:36 INFO - PROCESS | 5940 | 21:18:38 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:18:39 INFO - PROCESS | 5940 | RSS: Main: 147849216 21:18:39 INFO - PROCESS | 5940 | 21:18:42 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33401/tests/kraken/driver.html?testName=imaging-darkroom) 21:18:43 INFO - PROCESS | 5940 | RSS: Main: 147156992 21:18:43 INFO - PROCESS | 5940 | 21:18:46 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33401/tests/kraken/driver.html?testName=imaging-desaturate) 21:18:47 INFO - PROCESS | 5940 | RSS: Main: 148713472 21:18:47 INFO - PROCESS | 5940 | 21:18:49 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33401/tests/kraken/driver.html?testName=json-parse-financial) 21:18:50 INFO - PROCESS | 5940 | RSS: Main: 148729856 21:18:50 INFO - PROCESS | 5940 | 21:18:52 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:18:52 INFO - PROCESS | 5940 | RSS: Main: 149274624 21:18:52 INFO - PROCESS | 5940 | 21:18:54 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33401/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:18:55 INFO - PROCESS | 5940 | RSS: Main: 149532672 21:18:55 INFO - PROCESS | 5940 | 21:18:57 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:18:58 INFO - PROCESS | 5940 | RSS: Main: 149659648 21:18:58 INFO - PROCESS | 5940 | 21:19:00 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:19:01 INFO - PROCESS | 5940 | RSS: Main: 147628032 21:19:01 INFO - PROCESS | 5940 | 21:19:03 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:19:04 INFO - PROCESS | 5940 | RSS: Main: 149024768 21:19:04 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | Cycle 1(1): loaded http://localhost:33401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33401/tests/kraken/driver.html?testName=ai-astar) 21:19:06 INFO - PROCESS | 5940 | RSS: Main: 148910080 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | __start_tp_report 21:19:06 INFO - PROCESS | 5940 | _x_x_mozilla_page_load 21:19:06 INFO - PROCESS | 5940 | _x_x_mozilla_page_load_details 21:19:06 INFO - PROCESS | 5940 | |i|pagename|runs| 21:19:06 INFO - PROCESS | 5940 | |0;ai-astar;113;108;113;112;113;124;112;112;113;113 21:19:06 INFO - PROCESS | 5940 | |1;audio-beat-detection;152;133;158;163;133;160;151;134;180;134 21:19:06 INFO - PROCESS | 5940 | |2;audio-dft;161;164;161;163;162;164;172;164;167;166 21:19:06 INFO - PROCESS | 5940 | |3;audio-fft;75;74;72;74;85;134;72;75;72;75 21:19:06 INFO - PROCESS | 5940 | |4;audio-oscillator;96;98;137;97;98;97;140;98;96;128 21:19:06 INFO - PROCESS | 5940 | |5;imaging-gaussian-blur;111;110;110;110;109;111;110;109;110;110 21:19:06 INFO - PROCESS | 5940 | |6;imaging-darkroom;147;147;147;147;148;147;147;148;148;148 21:19:06 INFO - PROCESS | 5940 | |7;imaging-desaturate;97;96;99;98;96;96;106;96;96;96 21:19:06 INFO - PROCESS | 5940 | |8;json-parse-financial;70;70;73;71;72;71;71;71;70;68 21:19:06 INFO - PROCESS | 5940 | |9;json-stringify-tinderbox;67;68;68;68;68;68;69;70;68;68 21:19:06 INFO - PROCESS | 5940 | |10;stanford-crypto-aes;82;87;85;84;94;84;85;91;85;82 21:19:06 INFO - PROCESS | 5940 | |11;stanford-crypto-ccm;123;121;136;131;136;121;138;124;131;122 21:19:06 INFO - PROCESS | 5940 | |12;stanford-crypto-pbkdf2;146;149;161;151;155;150;141;140;138;137 21:19:06 INFO - PROCESS | 5940 | |13;stanford-crypto-sha256-iterative;73;73;72;72;72;72;71;70;70;71 21:19:06 INFO - PROCESS | 5940 | __end_tp_report 21:19:06 INFO - PROCESS | 5940 | __start_cc_report 21:19:06 INFO - PROCESS | 5940 | _x_x_mozilla_cycle_collect,800 21:19:06 INFO - PROCESS | 5940 | __end_cc_report 21:19:06 INFO - PROCESS | 5940 | __startTimestamp1452403146596__endTimestamp 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | ------- Summary: start ------- 21:19:06 INFO - PROCESS | 5940 | Number of tests: 14 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.06 (3.6%) stddev-sans-first:4.30 21:19:06 INFO - PROCESS | 5940 | Values: 113.0 108.0 113.0 112.0 113.0 124.0 112.0 112.0 113.0 113.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:155.00 stddev:16.08 (10.4%) stddev-sans-first:17.04 21:19:06 INFO - PROCESS | 5940 | Values: 152.0 133.0 158.0 163.0 133.0 160.0 151.0 134.0 180.0 134.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.31 (2.0%) stddev-sans-first:3.27 21:19:06 INFO - PROCESS | 5940 | Values: 161.0 164.0 161.0 163.0 162.0 164.0 172.0 164.0 167.0 166.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.50 stddev:19.07 (25.6%) stddev-sans-first:20.11 21:19:06 INFO - PROCESS | 5940 | Values: 75.0 74.0 72.0 74.0 85.0 134.0 72.0 75.0 72.0 75.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:97.00 stddev:18.54 (19.1%) stddev-sans-first:19.10 21:19:06 INFO - PROCESS | 5940 | Values: 96.0 98.0 137.0 97.0 98.0 97.0 140.0 98.0 96.0 128.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 21:19:06 INFO - PROCESS | 5940 | Values: 111.0 110.0 110.0 110.0 109.0 111.0 110.0 109.0 110.0 110.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:19:06 INFO - PROCESS | 5940 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 148.0 148.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:96.00 stddev:3.13 (3.3%) stddev-sans-first:3.32 21:19:06 INFO - PROCESS | 5940 | Values: 97.0 96.0 99.0 98.0 96.0 96.0 106.0 96.0 96.0 96.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:71.00 stddev:1.34 (1.9%) stddev-sans-first:1.39 21:19:06 INFO - PROCESS | 5940 | Values: 70.0 70.0 73.0 71.0 72.0 71.0 71.0 71.0 70.0 68.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 21:19:06 INFO - PROCESS | 5940 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 69.0 70.0 68.0 68.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:3.84 (4.5%) stddev-sans-first:3.81 21:19:06 INFO - PROCESS | 5940 | Values: 82.0 87.0 85.0 84.0 94.0 84.0 85.0 91.0 85.0 82.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:131.00 stddev:6.83 (5.2%) stddev-sans-first:6.97 21:19:06 INFO - PROCESS | 5940 | Values: 123.0 121.0 136.0 131.0 136.0 121.0 138.0 124.0 131.0 122.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:149.50 stddev:7.86 (5.3%) stddev-sans-first:8.33 21:19:06 INFO - PROCESS | 5940 | Values: 146.0 149.0 161.0 151.0 155.0 150.0 141.0 140.0 138.0 137.0 21:19:06 INFO - PROCESS | 5940 | 21:19:06 INFO - PROCESS | 5940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.07 (1.5%) stddev-sans-first:1.01 21:19:06 INFO - PROCESS | 5940 | Values: 73.0 73.0 72.0 72.0 72.0 72.0 71.0 70.0 70.0 71.0 21:19:06 INFO - PROCESS | 5940 | -------- Summary: end -------- 21:19:06 INFO - PROCESS | 5940 | 21:19:07 INFO - TEST-INFO | 5940: exit 0 21:19:07 INFO - TEST-OK | kraken | took 61318ms 21:19:07 INFO - TEST-START | v8_7 21:19:07 INFO - operating with platform_type : linux_ 21:19:07 INFO - Initialising browser for v8_7 test... 21:19:07 INFO - TEST-INFO | started process 6225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprMGLao/profile http://localhost:33401/getInfo.html) 21:19:11 INFO - PROCESS | 6225 | 21:19:11 INFO - PROCESS | 6225 | (process:6296): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:19:11 INFO - PROCESS | 6225 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 21:19:12 INFO - PROCESS | 6225 | __metrics Screen width/height:1600/1200 21:19:12 INFO - PROCESS | 6225 | colorDepth:24 21:19:12 INFO - PROCESS | 6225 | Browser inner width/height: 1024/697 21:19:12 INFO - PROCESS | 6225 | __metrics 21:19:12 INFO - PROCESS | 6225 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:19:13 INFO - TEST-INFO | 6225: exit 0 21:19:13 INFO - Browser initialized. 21:19:13 INFO - Running cycle 1/1 for v8_7 test... 21:19:13 INFO - TEST-INFO | started process 6345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprMGLao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:19:14 INFO - PROCESS | 6345 | 21:19:14 INFO - PROCESS | 6345 | (process:6402): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:19:25 INFO - PROCESS | 6345 | RSS: Main: 150339584 21:19:25 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | Cycle 1(1): loaded http://localhost:33401/tests/v8_7/run.html (next: http://localhost:33401/tests/v8_7/run.html) 21:19:47 INFO - PROCESS | 6345 | RSS: Main: 145743872 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | __start_tp_report 21:19:47 INFO - PROCESS | 6345 | _x_x_mozilla_page_load 21:19:47 INFO - PROCESS | 6345 | _x_x_mozilla_page_load_details 21:19:47 INFO - PROCESS | 6345 | |i|pagename|runs| 21:19:47 INFO - PROCESS | 6345 | |0;Richards;167.64459346186086 21:19:47 INFO - PROCESS | 6345 | |1;DeltaBlue;186.21973929236498 21:19:47 INFO - PROCESS | 6345 | |2;Encrypt;279.3296089385475 21:19:47 INFO - PROCESS | 6345 | |3;Decrypt;5181.347150259067 21:19:47 INFO - PROCESS | 6345 | |4;RayTrace;1109.8779134295228 21:19:47 INFO - PROCESS | 6345 | |5;Earley;757.002271006813 21:19:47 INFO - PROCESS | 6345 | |6;Boyer;12370.37037037037 21:19:47 INFO - PROCESS | 6345 | |7;RegExp;43500 21:19:47 INFO - PROCESS | 6345 | |8;Splay;602.1505376344086 21:19:47 INFO - PROCESS | 6345 | |9;NavierStokes;4826.923076923077 21:19:47 INFO - PROCESS | 6345 | __end_tp_report 21:19:47 INFO - PROCESS | 6345 | __startTimestamp1452403187850__endTimestamp 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | ------- Summary: start ------- 21:19:47 INFO - PROCESS | 6345 | Number of tests: 10 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 167.6 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#1] DeltaBlue Cycles:1 Average:186.22 Median:186.22 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 186.2 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 279.3 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 5181.3 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 1109.9 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#5] Earley Cycles:1 Average:757.00 Median:757.00 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 757.0 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 12370.4 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#7] RegExp Cycles:1 Average:43500.00 Median:43500.00 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 43500.0 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#8] Splay Cycles:1 Average:602.15 Median:602.15 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 602.2 21:19:47 INFO - PROCESS | 6345 | 21:19:47 INFO - PROCESS | 6345 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 21:19:47 INFO - PROCESS | 6345 | Values: 4826.9 21:19:47 INFO - PROCESS | 6345 | -------- Summary: end -------- 21:19:47 INFO - PROCESS | 6345 | 21:19:48 INFO - TEST-INFO | 6345: exit 0 21:19:48 INFO - TEST-OK | v8_7 | took 41132ms 21:19:48 INFO - SUITE-END | took 1217s 21:19:48 INFO - Completed test suite (00:20:17) 21:19:48 INFO - Working with test: dromaeo_css 21:19:48 INFO - Generating results file: dromaeo_css 21:19:48 INFO - Working with test: kraken 21:19:48 INFO - Generating results file: kraken 21:19:48 INFO - javascript benchmark 21:19:48 INFO - Working with test: v8_7 21:19:48 INFO - Generating results file: v8_7 21:19:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:19:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 21:19:48 INFO - process_Request line: dromaeo_css 6142.62 graph.html#tests=[[72,132,43]] 21:19:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:19:48 INFO - process_Request line: kraken 1543.30 graph.html#tests=[[232,132,43]] 21:19:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:19:48 INFO - process_Request line: v8_7 20082.80 graph.html#tests=[[230,132,43]] 21:19:48 INFO - RETURN: dromaeo_css: 6142.62 21:19:48 INFO - RETURN: kraken: 1543.30 21:19:48 INFO - RETURN: v8_7: 20082.80 21:19:48 INFO - javascript benchmark 21:19:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2636.2618466829285, 2705.702372738997, 2726.7273272672737, 2728.6862010868745, 2747.203311039798, 4474.843380481684, 4592.357070010197, 4618.792154353054, 4623.537646235375, 4656.9534304656945, 4506.098780243956, 4539.296409056601, 4589.265717485195, 4641.559051890065, 4656.534346565341, 4252.425922500469, 4265.893352666177, 4323.632491238232, 4338.826446942118, 4383.495897971727, 4278.679099067567, 4319.460067491564, 4321.783910804447, 4354.7604881731495, 4369.6285815705705, 4176.498820141572, 4216.9156616867795, 4262.424572682679, 4271.444712187395, 4288.892777680536, 4207.558206388347, 4211.05251318454, 4219.641330486912, 4219.9578004219875, 4236.131593023423, 4135.710500264982, 4184.832606695729, 4189.8477918572335, 4190.455240818705, 4194.517630472474, 4383.583559561836, 4442.53353397895, 4487.080148569536, 4513.413256276696, 4560.429946256718, 4874.902501949941, 4880.731559764212, 4886.218205087169, 4895.069936712049, 4901.509849015106, 4903.53416425439, 4909.8772530686665, 4911.901761964777, 4916.287138364917, 4918.557329840296, 4570.771461426949, 4627.976860115745, 4629.953700463019, 4631.235846085358, 4678.859634210945, 5049.495050494921, 5051.318072060299, 5051.545360917535, 5062.924056139161, 5076.035553244872, 4769.928451073237, 4819.807207711652, 4831.541003604652, 4847.418309802846, 4889.4377146627885, 4961.627877909099, 4963.205887058053, 4970.8757281068265, 4989.201727723546, 4997.775100120503, 4887.560119589183, 4925.38432695913, 4931.605471562267, 4936.48166942473, 4967.627427942919, 4750.714957102585, 4768.594669453136, 4798.47216806151, 4904.117258893362, 4935.531124543163, 4149.2738770715005, 4154.127633197002, 4158.91682166355, 4159.10579225468, 4178.791060446965, 3657.6890964267805, 3666.6699997000396, 3673.8897833065053, 3702.2225332680437, 3704.111013356829, 4141.544430112685, 4240.406343111967, 4245.957540424618, 4306.763128027926, 4324.78376081201, 4955.405351357788, 4979.875503112378, 4981.726005069683, 4986.077575648516, 5029.094762942632, 4134.111166099303, 4294.312909934395, 4296.205202037633, 4298.226319262562, 4332.6317263033, 4326.480822301344, 4351.26028575143, 4385.736855788663, 4389.780510974439, 4420.7126536775, 4749.715017098985, 4755.95244047562, 4758.619310455225, 4758.881027974328, 4772.689775164603, 4813.446453657734, 4931.0877487663465, 5028.1200789860895, 5048.343715316985, 5072.416672082758, 4687.414073240845, 4708.152532544175, 4731.716097034189, 4768.66619336657, 4825.469198388245, 4856.708597484162, 4885.5358740919555, 4894.779734911866, 4900.068986892479, 4931.13705101613, 4835.6131509478455, 4975.825846095369, 4980.825671101494, 4985.501449855131, 5036.722980235975, 4755.167845627071, 4778.426588809365, 4812.35033270504, 4823.5658790709, 4875.219964805614, 4836.685615434985, 4843.660943733905, 4865.172920603435, 4895.8041678332465, 4908.730019848943, 4526.072155208109, 4675.742834144155, 4778.904421911473, 4789.3055506952, 4857.635677324144, 4824.0834241494, 4909.4845041270155, 4912.631552633496, 4919.458859525521, 4957.752112394293, 4736.8578942631775, 4761.0, 4781.187198176388, 4789.640776941674, 4805.639577031667], "unit": "score", "name": "dojo.html", "value": 4543.199670619362}, {"lowerIsBetter": false, "replicates": [483.66627027351126, 491.1674711364239, 494.44375078037206, 497.1895809829974, 513.7387713164183, 24905.252842414735, 32445.0, 32647.51028734565, 32796.67203327969, 32846.83576582114, 35752.10619734508, 36131.4580281296, 36258.0, 36495.08762280944, 36522.452163217575, 7460.776176714694, 7810.921890781105, 7816.335611473031, 7823.491473054261, 7824.647890844925, 7714.112877019131, 7924.128345881948, 7941.722039728611, 7957.840843183162, 7961.800954976114, 7913.129555748863, 7972.5216487010675, 8019.639116239783, 8021.157778433268, 8022.1576734442915, 7852.528848269122, 7915.762527124196, 7955.0, 7977.960110199441, 7980.4812687175145, 7738.342240909529, 7834.725784597512, 7859.174786647377, 7881.960590197013, 7885.605719714049, 36818.447723284175, 37293.44059839105, 37348.62651373479, 37363.626363736286, 37415.62584374149, 2805.6212411324414, 2967.6735559088484, 3037.5747395364665, 3138.2625083105454, 3363.7981721096567, 28195.154145375673, 28370.876268072414, 28766.137015889555, 28902.855485722437, 29195.270118247, 3278.918027049319, 3327.6505966873615, 3338.599368075822, 3348.3303339331987, 3398.762086653935, 212921.0, 212975.0, 213286.0, 214508.0, 215478.0, 46179.99999999933, 47156.292655610196, 54120.72939635276, 54742.452575474534, 54792.17811732827, 57944.71027644835, 58864.411355885895, 59083.40916590779, 59202.70398648065, 59255.40744592585, 13930.86069139316, 13945.442182312594, 13984.160950343012, 14036.0, 14141.5050473235, 11368.0, 11401.144914131473, 11485.712857178638, 11490.368029758443, 11491.885081149248, 17965.550861228312, 18091.185896634684, 18259.72610410845, 18819.153138108817, 19071.332503362315, 7079.6371723431985, 7382.667779949915, 7388.963055184797, 7394.704211831574, 7453.590052547162, 822.6339279020779, 828.5235989306173, 888.5823662878437, 902.869083982832, 936.8969413364524, 25630.74369256321, 26100.477990440086, 26271.737282627313, 26624.60063099055, 27027.324316892234, 897.1521911793293, 902.4900930973979, 941.087145468894, 944.3955868244329, 1013.4223492609142, 12557.686057848627, 12581.0, 12652.81020784689, 12785.936070319589, 12802.487900484062, 255016.0, 258482.0, 259617.0, 260832.08751868736, 260941.0, 45202.547974520494, 45571.54428455673, 45619.0, 45622.31566526505, 45721.77139114283, 1198.6344165029575, 1217.5373358124034, 1226.497136174182, 1244.3902487780922, 1251.0, 24568.38579035467, 24571.38571535726, 24950.126745564543, 25221.621675674513, 25566.10518631839, 40331.79834100928, 40836.0, 41066.1786764269, 41131.0, 41206.793966029974, 237299.0, 238957.0, 239559.0, 239603.0, 239707.0, 27946.0, 28714.282142945758, 29192.27019324534, 29291.41417171687, 29365.853170734863, 33337.0, 33744.49383259302, 34099.0, 34332.656673432946, 34415.65584344124, 31080.378392432478, 31334.373312534077, 31923.84038079795, 32018.839905800323, 32279.35441291208, 31758.36483270368, 31934.0, 32047.679523204468, 32225.51661725123, 32354.191145221557, 31625.8418707905, 31790.52314215335, 31937.361252775278, 32135.0, 32137.0, 27749.583756244076, 28947.131586052452, 29748.702512974593, 29829.0, 30415.087547373616, 21587.35237942864, 23681.17115900935, 25390.0, 25584.915841064674, 25586.61620075663], "unit": "score", "name": "ext.html", "value": 16431.750081509188}, {"lowerIsBetter": false, "replicates": [316.4272666473683, 316.6058257469448, 319.2147317598707, 321.12173206280835, 331.7710779562102, 14242.074265172769, 14752.262386880653, 14838.0, 14976.625584360369, 15692.0, 9586.568604412802, 9859.802803943916, 11554.53781848725, 14410.711785764279, 14471.131732096082, 4297.527272000078, 4362.25841606926, 4516.954830451687, 4551.590356867881, 4574.97712511437, 4418.204723149832, 4559.156556037127, 4562.270036794113, 4563.726176429408, 4565.977170114144, 3423.5035919791617, 4564.566366195206, 4574.519675434081, 4760.952390476085, 5133.922991155136, 5062.265971434122, 5078.466760990117, 5102.132637451642, 5102.413222479407, 5107.61692873036, 4856.927146092776, 5150.175971844525, 5155.871103222412, 5161.845144645667, 5169.0, 11291.830622540669, 11367.0, 11633.70915727105, 13614.842738367252, 18070.09649517519, 1788.1416919878402, 1793.2557988434785, 1816.4369045595909, 1881.1628825172804, 1891.0166713309002, 8342.457740246926, 8441.535715535643, 8543.102974187745, 8642.783930401727, 8717.564121793948, 340.8023346459048, 340.9974674457113, 1574.4804214609267, 1636.9754453683204, 1718.3708925344242, 43941.0, 46746.298805517945, 47174.76412617949, 48616.75691621519, 54268.457315426735, 9279.211267042241, 9650.324477286664, 9852.802943941224, 9856.50717464124, 9916.950415247878, 12343.382830858422, 12386.442610082388, 12423.130380873252, 12431.37843107841, 12443.813342799865, 7311.341979221896, 7311.744088956861, 7362.8527429451115, 7372.557646541225, 7397.778066658009, 7002.054722612382, 7025.648717564101, 7051.1186101737285, 7055.89416158758, 7091.787246382617, 3875.8062096895605, 3917.2948869203815, 4200.0, 4236.301010333261, 4273.081287523135, 1607.1401800036924, 1648.365379328967, 1702.7956645202407, 1710.9743353849701, 1756.2799252306493, 735.492510167993, 848.1010129263001, 905.3933864310927, 929.41158872541, 943.4763706143157, 14865.256737163314, 14935.402583896739, 14957.252137393087, 15101.848981510264, 15346.15596142223, 763.9159692433827, 814.3973459639942, 861.2291998661289, 900.6712549919363, 930.3812964378612, 8745.47527148373, 8755.343349248704, 8776.561171941377, 8781.51701656415, 9052.954735226282, 439191.0, 449124.0, 452227.0, 453156.0, 453477.0, 63639.72720545563, 65204.347956520774, 65261.0, 65288.0, 66386.33613663899, 1054.2725519391595, 1099.71957150926, 1108.3793075877534, 1112.6828853776797, 1117.8323251512338, 13127.934360328138, 13369.732605348034, 13505.797413038616, 13533.120347177402, 13845.584632461043, 27901.302467438476, 28374.716252837206, 28691.569626455203, 28850.134495965154, 28900.566491502224, 36568.26863462769, 36628.45057324196, 37336.813315934334, 38013.61986380101, 41960.79019604882, 6417.454516366161, 6679.9332006679315, 6815.829604259933, 6890.896636550556, 6968.407685346802, 8385.95807020961, 9668.888077870854, 9836.114749672564, 9865.950670246602, 10455.215858810467, 7615.02431814325, 8463.49219046859, 8649.264812490757, 8817.206451419403, 8921.509316987627, 8894.735006452196, 9109.453432794053, 9379.202767764817, 9726.465044422624, 9771.511424428892, 7764.029496312961, 8620.181082797124, 8874.112588741074, 8895.955520222358, 9220.861687074565, 6107.297660768891, 6260.780872669435, 6289.49684025286, 6399.520035997226, 6813.04617353561, 6686.0, 8193.67225310981, 8260.463069900437, 8301.792455188426, 8366.581670916308], "unit": "score", "name": "jquery.html", "value": 7190.39175519876}, {"lowerIsBetter": false, "replicates": [1383.7440073586388, 1394.9163050216987, 1525.5652139140348, 1715.416758302177, 1730.3597668862524, 6102.17620621216, 6250.749970001206, 7168.354848063674, 7294.671739771709, 7382.372498337648, 7165.283471652845, 7304.890426643605, 7371.37343325818, 7399.926000739991, 7463.738769143068, 2168.1869299012833, 2197.13213280754, 2197.48359135603, 2197.8351623628214, 2200.3508964855328, 2132.2217390652454, 2167.5989941860807, 2209.5359974405396, 2231.966520502194, 2235.7428895677044, 2188.5622875424897, 2197.165077270635, 2209.9889500552476, 2210.6573481110454, 2220.666899965002, 2097.81119699227, 2105.3262955854134, 2110.7150534677776, 2111.1133324003877, 2117.9682304765442, 2154.332157031325, 2193.1665966932624, 2195.6047911375945, 2200.262911924507, 2201.020545857094, 7495.625218739041, 7512.0, 7548.358389536841, 7549.433792465532, 7560.924390756077, 4345.044090300129, 4465.531119232466, 4471.016376397188, 4487.6634252431195, 4490.3488994096, 2909.3890283040587, 2949.1594895454905, 2978.9851050744824, 2990.476666583339, 2994.6406431228174, 928.3594319919234, 957.6504575829772, 963.8843338799389, 981.842905135182, 989.5794287427815, 10258.743531411774, 10309.484525773682, 10311.0, 10313.845292320697, 10324.380537167719, 4039.4546736190237, 4054.128362402039, 4069.613386728256, 4115.855945041969, 4120.690948178899, 8798.164174403422, 8863.512506812058, 8864.290856731446, 8868.246199073152, 8887.600057997406, 4392.5607439256455, 4395.362672412482, 4403.207422663887, 4418.756968366706, 4432.29083346663, 3359.8488068036995, 3446.069561218457, 3911.6870650347905, 3971.146203566247, 3987.860424885115, 3551.9112022199133, 3589.2283159120393, 3613.855445782139, 3619.221867298491, 3624.9637503624626, 1169.3159501691437, 1171.4377098992532, 1174.236746115032, 1183.556166437586, 1188.5245901639241, 912.9315301352425, 923.1460898668705, 931.5016466190556, 945.8817647794026, 1202.0323639470137, 6499.805005849832, 6501.44737697301, 6538.476921846241, 6553.148090748172, 6563.7702680405955, 443.39698010705416, 444.7242709520118, 446.55790767140945, 449.4247363374885, 455.574038274208, 5436.510714035677, 5496.5053145217125, 5499.0, 5507.311586051744, 5542.11326187808, 8353.498790072616, 8778.868316975251, 8821.823563528693, 8850.822983540293, 8911.0, 8635.266002389868, 8654.134586541295, 8686.0, 8700.216980471661, 8713.390062695551, 6860.588364698134, 6915.377616014583, 7033.156021277479, 7071.858562828715, 7173.246809085075, 6589.80230593083, 6627.1716035495565, 6637.203535575762, 6640.402363787282, 6647.335266473314, 7555.622218889143, 7843.333316668147, 7892.329152022143, 7895.249951254622, 8013.879791803244, 7990.720324788605, 8276.917230827614, 8294.336453083619, 8385.790355241168, 8399.580020998803, 5202.427732949448, 6157.230346206724, 6161.876762464636, 6189.669221117481, 6358.682065896594, 6830.897536537055, 7005.824854378681, 7029.859402811813, 7032.331928466788, 7047.330503602149, 6570.5729127606555, 6605.339466053356, 6654.0, 6754.088198093391, 6840.3501667341525, 6513.478921686348, 6530.47756179514, 6676.365745254193, 6740.62926539045, 6802.489813263926, 6487.1566696331065, 6561.80314590563, 6572.76995305162, 6573.704183311858, 6583.703733331916, 6066.939330606638, 6084.361142080195, 6111.0, 6164.907526387018, 6174.104754810617, 6026.276846778414, 6100.298465676504, 6100.938990610037, 6102.603330783485, 6104.4200800923845], "unit": "score", "name": "mootools.html", "value": 4135.941512733751}, {"lowerIsBetter": false, "replicates": [300.2628546917318, 309.21151064784806, 310.37149771712274, 316.0376653091338, 318.0728177362987, 5444.754986025629, 5454.781808727651, 5586.86032849179, 5591.860203494904, 5633.408492108326, 5408.323959505062, 5521.972390138044, 5540.141278101891, 5542.8337149885465, 5553.72231388431, 4310.461192350964, 4316.503602085769, 4317.848875289365, 4320.049589090395, 4325.394444777734, 4302.913941721164, 4307.633851122659, 4310.547392523787, 4311.051568654907, 4312.525622181557, 4057.2494088593558, 4185.121124563845, 4274.636655884238, 4308.504521979966, 4311.3748506466545, 4188.287991041515, 4198.307279298912, 4224.281872081753, 4228.577142285747, 4232.32282834748, 3688.0779805048737, 3693.279810436966, 3695.3533131701843, 3699.223163135745, 3702.7222958277966, 5260.473952604747, 5367.516923476866, 5372.892542149174, 5379.273798037254, 5381.9461805382225, 4858.344123543312, 4880.902381952376, 4885.071836351118, 4890.24201248807, 4893.168161412568, 5812.157237200625, 5834.183214349994, 5842.620229685057, 5847.8245652630485, 5853.5317174625925, 3874.341361968444, 4015.578364271739, 4016.6987475939422, 4026.59734026595, 4033.4353190553347, 6022.6687532185715, 6109.816705498843, 6124.7243874025335, 6129.356417576179, 6131.816045518686, 4133.0700592366475, 4135.400366946836, 4135.524414692349, 4136.627703506699, 4145.0880806222585, 4195.098053918422, 4197.4753155855515, 4200.7479551227025, 4203.117345357448, 4210.200061988213, 4718.386609740781, 4820.3492528508905, 4824.541668541483, 4828.227483602677, 4830.492798256132, 5808.6224395414165, 5810.389909059488, 5814.215080964016, 5815.82552523425, 5821.446962538552, 1473.5579326202096, 1494.1707352419512, 1494.7010597880467, 1494.7907292978773, 1496.416397604913, 996.8006398720285, 1006.0693858181153, 1008.3899240959114, 1011.6610935336745, 1025.5795123999123, 5033.723145226974, 5040.697558146449, 5057.570106540912, 5062.367204099488, 5063.291139240509, 6070.635761854214, 6072.878542429126, 6075.544334174954, 6078.45293923549, 6087.54343424245, 5013.147764879906, 5018.447970723218, 5019.598432125421, 5049.722265275372, 5054.418741844662, 3207.1661368044474, 3265.689759472846, 3272.640009598942, 3287.1946373138735, 3296.3736889990823, 5601.495865372054, 5716.5140963017775, 5725.570582206351, 5726.055200891889, 5732.426757324234, 6265.216847894013, 6286.4342209201395, 6293.433590976834, 6293.653849038347, 6293.748250070037, 5789.594728369058, 5793.681347525842, 5841.649501029951, 5848.53211743051, 5852.473277404969, 6117.0, 6124.050772130327, 6143.385661433821, 6146.6004709693725, 6148.077788331786, 5830.18377427169, 5906.763729450774, 5909.940900590939, 5911.881762364643, 5918.556108291809, 5725.971370143123, 5769.942300577109, 5790.0, 5791.0, 5803.506701930214, 4249.426327445879, 4297.957020429756, 4299.935500967551, 4303.612674859278, 4306.138772245501, 5928.0, 6021.578489505868, 6039.939600603938, 6048.213732214784, 6048.788292409745, 5817.2146760188525, 5818.040023396262, 5823.854403639943, 5827.038538641077, 5827.621204621686, 5815.302163740378, 5822.912656310244, 5828.2423284974375, 5850.0932355484965, 5893.057110862242, 5582.0789569722165, 5695.857603559944, 5699.373068962494, 5712.971435142797, 5727.11229759388, 5820.912686309794, 5829.417058294306, 5840.737166827418, 5848.181254624441, 5857.384974577779, 5632.5493960482245, 5639.407862174413, 5646.548276137817, 5678.716064196691, 5682.5453963681975], "unit": "score", "name": "prototype.html", "value": 4370.972765360524}, {"lowerIsBetter": false, "replicates": [748.5920173505439, 762.7254188492142, 772.7720322504861, 780.9492382995109, 788.2432864450128, 10641.680749577516, 10744.838827417596, 10766.892331076688, 10772.245942784008, 10772.838407423895, 10473.633422830202, 10565.260431769779, 10597.682069537927, 10602.204834637394, 10604.363738175714, 584.7660935625762, 606.3936063936064, 755.6486233901221, 758.321302434321, 764.644440335244, 746.2090184404522, 752.8607207666572, 753.2053683364048, 758.8065043413922, 761.958092304923, 807.7172989453703, 807.7818988873, 807.9798005049862, 808.5431731071955, 811.9106898241189, 799.6161842315692, 799.952002879829, 801.9198080191934, 806.3267171911461, 807.4953154278576, 594.3729365519375, 598.317917573966, 598.5241732822417, 599.0176111177672, 601.5788947736602, 11498.942505287503, 11564.768704625945, 11604.30374177552, 11615.767684646344, 11640.126990475748, 11889.881101188965, 11959.162858599902, 12015.0, 12144.817827732591, 12228.266304021787, 9181.81636367269, 9420.340576159671, 9485.241180705527, 9505.809883802354, 9591.856122158173, 3932.9803350983348, 3986.80065996699, 4016.116454380032, 4125.566815484361, 4148.709590328678, 36103.81948090269, 36151.09622259438, 36347.63652363495, 36546.0, 36646.0, 8889.0, 9015.14356136166, 9256.861147082664, 9308.581113849894, 9387.859182112274, 15210.391584336503, 15796.763048554281, 15820.604484887739, 15830.920845395929, 15831.683366332609, 6053.697315134225, 6103.786367477117, 6162.352952939877, 6213.720382582795, 6236.563440559208, 3576.964230357715, 3634.7819130852236, 3637.7999210043704, 3647.106458917582, 3696.1868388954385, 2618.16218809979, 2632.0129951268273, 2632.3813903732607, 2641.181233817484, 2643.828151170168, 489.8334566247493, 499.88002879308704, 500.46450298181327, 500.76213798446173, 505.4945054945055, 436.16474451425165, 475.96668233224034, 490.8527441767527, 520.1729250491736, 541.7643325153571, 7117.6085315308155, 7165.283471652897, 7225.096862892138, 7311.744088956861, 8339.12439193888, 459.7264627546604, 482.92031814750874, 539.5764325004852, 592.4194289596134, 627.66106302597, 3351.5307856899567, 3525.9471107932886, 3564.1802385450974, 3590.5225394477725, 3618.9095272618397, 45289.0, 45476.3178552322, 45647.0, 45736.542634573896, 46004.309935351, 42493.787531062146, 42966.35550466745, 43340.78329608332, 43476.130477390274, 43654.0, 38011.80994095067, 38217.0, 38233.23533529314, 39433.60566394357, 40005.19989600192, 7858.057033155829, 8041.557714325768, 8062.072861620989, 8140.267375936194, 8198.38512111606, 30501.389972199988, 30913.8454307727, 31052.689473105882, 31629.209269767518, 31712.682873170972, 34884.47673284852, 35435.291294173454, 37315.0, 39284.6071539281, 39392.60607394004, 9812.26408019387, 10291.33106348085, 10375.118114960313, 10431.0, 10646.414447205478, 10620.582245118167, 10665.485263152483, 10686.358818470917, 10693.9465302673, 10839.837402438812, 10193.0, 10206.030427109412, 10215.489225538842, 10216.489175541343, 10275.588976440858, 9594.904050959402, 9627.326087173831, 9645.131938125602, 9645.662401815904, 9656.082672146134, 9767.511624418892, 9889.604415823287, 9910.554025068745, 9976.551055202679, 9982.101610854768, 7748.535087894745, 8038.236367545074, 8039.115697273179, 8182.631781569963, 8236.629351679308, 8656.26421754158, 8850.822983540163, 8871.911280887109, 8908.688195913111, 8960.103989600988], "unit": "score", "name": "yui.html", "value": 5535.175768212745}], "name": "dromaeo_css", "value": 6142.622899508438}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 113.0, 112.0, 113.0, 124.0, 112.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [152.0, 133.0, 158.0, 163.0, 133.0, 160.0, 151.0, 134.0, 180.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 161.0, 163.0, 162.0, 164.0, 172.0, 164.0, 167.0, 166.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 72.0, 74.0, 85.0, 134.0, 72.0, 75.0, 72.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 137.0, 97.0, 98.0, 97.0, 140.0, 98.0, 96.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 99.0, 98.0, 96.0, 96.0, 106.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.6}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 73.0, 71.0, 72.0, 71.0, 71.0, 71.0, 70.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 70.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 87.0, 85.0, 84.0, 94.0, 84.0, 85.0, 91.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [123.0, 121.0, 136.0, 131.0, 136.0, 121.0, 138.0, 124.0, 131.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.3}, {"lowerIsBetter": true, "replicates": [146.0, 149.0, 161.0, 151.0, 155.0, 150.0, 141.0, 140.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 72.0, 72.0, 72.0, 71.0, 70.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1543.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [186.21973929236498], "unit": "score", "name": "DeltaBlue", "value": 355.0536599999999}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1109.8779134295228], "unit": "score", "name": "RayTrace", "value": 666.7300889999998}, {"lowerIsBetter": false, "replicates": [757.002271006813], "unit": "score", "name": "Earley", "value": 880.3976229999998}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [43500.0], "unit": "score", "name": "RegExp", "value": 20.94218390804596}, {"lowerIsBetter": false, "replicates": [602.1505376344086], "unit": "score", "name": "Splay", "value": 135.3332678571428}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20082.799490011563}]} 21:19:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20082.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1543.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6142.62"}}} 21:19:49 INFO - Return code: 0 21:19:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:19:49 INFO - # TBPL SUCCESS # 21:19:49 INFO - Running post-action listener: _resource_record_post_action 21:19:49 INFO - Running post-run listener: _resource_record_post_run 21:19:50 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 554573824; Read time: 0; Write time: 618176 21:19:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231882752; Read time: 0; Write time: 348672 21:19:50 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 322494464; Read time: 0; Write time: 269480 21:19:50 INFO - Running post-run listener: _upload_blobber_files 21:19:50 INFO - Blob upload gear active. 21:19:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:19:50 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 21:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:19:50 INFO - (blobuploader) - INFO - Open directory for files ... 21:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:19:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:51 INFO - (blobuploader) - INFO - Done attempting. 21:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:52 INFO - (blobuploader) - INFO - Done attempting. 21:19:52 INFO - (blobuploader) - INFO - Iteration through files over. 21:19:52 INFO - Return code: 0 21:19:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:19:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:19:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a8b4d190212b440bcae6ae6ef3aefbb4ff15b7b69eb8ea62c910f08beca4b68399695acde2ad84850316f8b6e0c35a8d94bf1ced6d7df59840f58322d0ccd68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20ddb27b20cbc3f306879ab5c980db327214480f8efe845146db1180728e674f0df13ca8c13282110249e021309e537ff74ff47baa4ffcd878a903012577b383"} 21:19:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:19:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:19:52 INFO - Contents: 21:19:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a8b4d190212b440bcae6ae6ef3aefbb4ff15b7b69eb8ea62c910f08beca4b68399695acde2ad84850316f8b6e0c35a8d94bf1ced6d7df59840f58322d0ccd68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20ddb27b20cbc3f306879ab5c980db327214480f8efe845146db1180728e674f0df13ca8c13282110249e021309e537ff74ff47baa4ffcd878a903012577b383"} 21:19:52 INFO - Copying logs to upload dir... 21:19:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.902617 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-01-09 21:19:52.171927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 21:19:52.175431) ========= 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=62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a8b4d190212b440bcae6ae6ef3aefbb4ff15b7b69eb8ea62c910f08beca4b68399695acde2ad84850316f8b6e0c35a8d94bf1ced6d7df59840f58322d0ccd68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20ddb27b20cbc3f306879ab5c980db327214480f8efe845146db1180728e674f0df13ca8c13282110249e021309e537ff74ff47baa4ffcd878a903012577b383"} build_url:https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8a8b4d190212b440bcae6ae6ef3aefbb4ff15b7b69eb8ea62c910f08beca4b68399695acde2ad84850316f8b6e0c35a8d94bf1ced6d7df59840f58322d0ccd68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20ddb27b20cbc3f306879ab5c980db327214480f8efe845146db1180728e674f0df13ca8c13282110249e021309e537ff74ff47baa4ffcd878a903012577b383"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 21:19:52.204810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 21:19:52.205158) ========= 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=62c568580acbfdaac3eec7be000001dc-1452399307.947534-738390014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 21:19:52.288139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 21:19:52.288776) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 21:19:52.289226) ========= ========= Total master_lag: 0.37 =========