builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1452380629.82 results: success (0) buildid: 20160109142731 builduid: 102ce7d37fd5401e80024a6d4d331717 revision: af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:49.818148) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:49.818662) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:49.818978) ========= 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=0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006460 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:49.861550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:49.861850) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:49.970456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:49.971048) ========= 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=0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.045898) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.046180) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.046560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.046839) ========= 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=0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 15:03:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-01-09 15:03:50 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172705 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.239594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.239884) ========= 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=0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.289028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.289339) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c --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 af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c --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=0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 15:03:50,509 truncating revision to first 12 chars 2016-01-09 15:03:50,509 Setting DEBUG logging. 2016-01-09 15:03:50,509 attempt 1/10 2016-01-09 15:03:50,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af1d9d9f34ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 15:03:50,764 unpacking tar archive at: fx-team-af1d9d9f34ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562458 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.864348) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.864662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.874863) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.875288) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 15:03:50.875770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-09 15:03:50.876067) ========= /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=0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:03:51 INFO - MultiFileLogger online at 20160109 15:03:51 in /builds/slave/test 15:03:51 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 15:03:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:03:51 INFO - {'append_to_log': False, 15:03:51 INFO - 'base_work_dir': '/builds/slave/test', 15:03:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:03:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:03:51 INFO - 'branch': 'Fx-Team-Non-PGO', 15:03:51 INFO - 'buildbot_json_path': 'buildprops.json', 15:03:51 INFO - 'config_files': ('talos/linux_config.py',), 15:03:51 INFO - 'default_actions': ('clobber', 15:03:51 INFO - 'read-buildbot-config', 15:03:51 INFO - 'download-and-extract', 15:03:51 INFO - 'populate-webroot', 15:03:51 INFO - 'create-virtualenv', 15:03:51 INFO - 'install', 15:03:51 INFO - 'run-tests'), 15:03:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:03:51 INFO - 'download_minidump_stackwalk': True, 15:03:51 INFO - 'download_symbols': 'ondemand', 15:03:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:03:51 INFO - 'tooltool.py': '/tools/tooltool.py', 15:03:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:03:51 INFO - '/tools/misc-python/virtualenv.py')}, 15:03:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:03:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:03:51 INFO - 'installer_path': 'installer.exe', 15:03:51 INFO - 'log_level': 'info', 15:03:51 INFO - 'log_name': 'talos', 15:03:51 INFO - 'log_to_console': True, 15:03:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:03:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:03:51 INFO - 'opt_config_files': (), 15:03:51 INFO - 'pip_index': False, 15:03:51 INFO - 'sps_profile': False, 15:03:51 INFO - 'sps_profile_interval': 0, 15:03:51 INFO - 'suite': 'dromaeojs-e10s', 15:03:51 INFO - 'system_bits': '32', 15:03:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:03:51 INFO - 'title': 'talos-linux64-ix-029', 15:03:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:03:51 INFO - 'use_talos_json': True, 15:03:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:03:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:03:51 INFO - 'work_dir': 'build'} 15:03:51 INFO - ##### 15:03:51 INFO - ##### Running clobber step. 15:03:51 INFO - ##### 15:03:51 INFO - Running pre-action listener: _resource_record_pre_action 15:03:51 INFO - Running main action method: clobber 15:03:51 INFO - rmtree: /builds/slave/test/build 15:03:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:03:51 INFO - Running post-action listener: _resource_record_post_action 15:03:51 INFO - ##### 15:03:51 INFO - ##### Running read-buildbot-config step. 15:03:51 INFO - ##### 15:03:51 INFO - Running pre-action listener: _resource_record_pre_action 15:03:51 INFO - Running main action method: read_buildbot_config 15:03:51 INFO - Using buildbot properties: 15:03:51 INFO - { 15:03:51 INFO - "project": "", 15:03:51 INFO - "product": "firefox", 15:03:51 INFO - "script_repo_revision": "production", 15:03:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:03:51 INFO - "repository": "", 15:03:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:03:51 INFO - "buildid": "20160109142731", 15:03:51 INFO - "pgo_build": "False", 15:03:51 INFO - "basedir": "/builds/slave/test", 15:03:51 INFO - "buildnumber": 627, 15:03:51 INFO - "slavename": "talos-linux64-ix-029", 15:03:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:03:51 INFO - "platform": "ubuntu64_hw", 15:03:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:03:51 INFO - "branch": "fx-team", 15:03:51 INFO - "repo_path": "integration/fx-team", 15:03:51 INFO - "revision": "af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c", 15:03:51 INFO - "stage_platform": "linux64", 15:03:51 INFO - "builduid": "102ce7d37fd5401e80024a6d4d331717", 15:03:51 INFO - "slavebuilddir": "test" 15:03:51 INFO - } 15:03:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:03:51 INFO - Running post-action listener: _resource_record_post_action 15:03:51 INFO - ##### 15:03:51 INFO - ##### Running download-and-extract step. 15:03:51 INFO - ##### 15:03:51 INFO - Running pre-action listener: _resource_record_pre_action 15:03:51 INFO - Running main action method: download_and_extract 15:03:51 INFO - mkdir: /builds/slave/test/build/tests 15:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:51 INFO - https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:03:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/test_packages.json 15:03:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/test_packages.json 15:03:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:03:58 INFO - Downloaded 1302 bytes. 15:03:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:03:58 INFO - Using the following test package requirements: 15:03:58 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:03:58 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:03:58 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:58 INFO - u'jsshell-linux-x86_64.zip'], 15:03:58 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:03:58 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:03:58 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:03:58 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:03:58 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:03:58 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:03:58 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:03:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:03: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')]} 15:03:58 INFO - https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:03:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:03:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:03:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/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 15:03:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/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 15:04:00 INFO - Downloaded 22761271 bytes. 15:04:00 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 15:04:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:04:00 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 15:04:01 INFO - Return code: 0 15:04:01 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 15:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:01 INFO - https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:04:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:04:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:04:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/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 15:04:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/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 15:04:07 INFO - Downloaded 22761271 bytes. 15:04:07 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 15:04:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:04:07 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 15:04:08 INFO - Return code: 0 15:04: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')]} 15:04:08 INFO - https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:04:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:04:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:04:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/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 15:04:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/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 15:04:09 INFO - Downloaded 11132285 bytes. 15:04:09 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 15:04:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:04:09 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 15:04:09 INFO - Return code: 0 15:04: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')]} 15:04:09 INFO - https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:04:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:04:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:04:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/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 15:04:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cI2APV0KSuixVrIgp9ROjQ/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 15:04:11 INFO - Downloaded 54049891 bytes. 15:04:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:04:11 INFO - mkdir: /builds/slave/test/properties 15:04:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:04:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:04:11 INFO - Contents: 15:04:11 INFO - build_url:https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:04:11 INFO - Running post-action listener: _resource_record_post_action 15:04:11 INFO - Running post-action listener: set_extra_try_arguments 15:04:11 INFO - ##### 15:04:11 INFO - ##### Running populate-webroot step. 15:04:11 INFO - ##### 15:04:11 INFO - Running pre-action listener: _resource_record_pre_action 15:04:11 INFO - Running main action method: populate_webroot 15:04:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:04:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:04:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:04:11 INFO - '--tppagecycles', 15:04:11 INFO - '7'], 15:04:11 INFO - 'tests': ['tsvgm']}}, 15:04:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:04:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:04:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:04:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:04:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:04:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:11 INFO - 'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:04:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:11 INFO - 'tests': ['damp', 'tps']}, 15:04:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:11 INFO - 'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['damp', 'tps']}, 15:04:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:04:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:04:11 INFO - 'other': {'tests': ['a11yr', 15:04:11 INFO - 'ts_paint', 15:04:11 INFO - 'tpaint', 15:04:11 INFO - 'sessionrestore', 15:04:11 INFO - 'sessionrestore_no_auto_restore']}, 15:04:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['a11yr', 15:04:11 INFO - 'ts_paint', 15:04:11 INFO - 'tpaint', 15:04:11 INFO - 'sessionrestore', 15:04:11 INFO - 'sessionrestore_no_auto_restore']}, 15:04:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['a11yr', 15:04:11 INFO - 'ts_paint', 15:04:11 INFO - 'tpaint', 15:04:11 INFO - 'sessionrestore', 15:04:11 INFO - 'sessionrestore_no_auto_restore']}, 15:04:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['a11yr', 15:04:11 INFO - 'ts_paint', 15:04:11 INFO - 'tpaint', 15:04:11 INFO - 'sessionrestore', 15:04:11 INFO - 'sessionrestore_no_auto_restore']}, 15:04:11 INFO - 'other_l64': {'tests': ['a11yr', 15:04:11 INFO - 'ts_paint', 15:04:11 INFO - 'tpaint', 15:04:11 INFO - 'sessionrestore', 15:04:11 INFO - 'sessionrestore_no_auto_restore']}, 15:04:11 INFO - 'other_nol64': {'tests': ['a11yr', 15:04:11 INFO - 'ts_paint', 15:04:11 INFO - 'tpaint', 15:04:11 INFO - 'sessionrestore', 15:04:11 INFO - 'sessionrestore_no_auto_restore']}, 15:04:11 INFO - 'svgr': {'tests': ['tsvgx', 15:04:11 INFO - 'tsvgr_opacity', 15:04:11 INFO - 'tart', 15:04:11 INFO - 'tscrollx', 15:04:11 INFO - 'cart']}, 15:04:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['tsvgx', 15:04:11 INFO - 'tsvgr_opacity', 15:04:11 INFO - 'tart', 15:04:11 INFO - 'tscrollx', 15:04:11 INFO - 'cart']}, 15:04:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:11 INFO - 'tests': ['tp5o']}, 15:04:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:11 INFO - 'talos_options': ['--e10s'], 15:04:11 INFO - 'tests': ['tp5o']}, 15:04:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:11 INFO - 'talos_options': ['--xperf_path', 15:04:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:04:11 INFO - 'tests': ['tp5n']}, 15:04:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:11 INFO - 'talos_options': ['--e10s', 15:04:11 INFO - '--xperf_path', 15:04:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:04:11 INFO - 'tests': ['tp5n']}}, 15:04:11 INFO - 'talos.zip': {'path': '', 15:04:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:04:11 INFO - Running post-action listener: _resource_record_post_action 15:04:11 INFO - ##### 15:04:11 INFO - ##### Running create-virtualenv step. 15:04:11 INFO - ##### 15:04:11 INFO - Running pre-action listener: _resource_record_pre_action 15:04:11 INFO - Running main action method: create_virtualenv 15:04:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:04:11 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 15:04:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:04:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:04:11 INFO - Using real prefix '/usr' 15:04:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:04:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:04:13 INFO - Installing pip.................done. 15:04:13 INFO - Return code: 0 15:04:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:13 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:13 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 15:04:13 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 15:04:13 INFO - Using env: {'DISPLAY': ':0', 15:04:13 INFO - 'HOME': '/home/cltbld', 15:04:13 INFO - 'LANG': 'en_US.UTF-8', 15:04:13 INFO - 'LANGUAGE': 'en_US:en', 15:04:13 INFO - 'LOGNAME': 'cltbld', 15:04:13 INFO - 'MAIL': '/var/mail/cltbld', 15:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:13 INFO - 'MOZ_NO_REMOTE': '1', 15:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:13 INFO - 'NO_EM_RESTART': '1', 15:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:13 INFO - 'PWD': '/builds/slave/test', 15:04:13 INFO - 'SHELL': '/bin/bash', 15:04:13 INFO - 'SHLVL': '1', 15:04:13 INFO - 'TERM': 'linux', 15:04:13 INFO - 'TMOUT': '86400', 15:04:13 INFO - 'USER': 'cltbld', 15:04:13 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:13 INFO - '_': '/tools/buildbot/bin/python'} 15:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:13 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 15:04:13 INFO - Cleaning up... 15:04:13 INFO - Return code: 0 15:04:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:13 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:13 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 15:04:13 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 15:04:13 INFO - Using env: {'DISPLAY': ':0', 15:04:13 INFO - 'HOME': '/home/cltbld', 15:04:13 INFO - 'LANG': 'en_US.UTF-8', 15:04:13 INFO - 'LANGUAGE': 'en_US:en', 15:04:13 INFO - 'LOGNAME': 'cltbld', 15:04:13 INFO - 'MAIL': '/var/mail/cltbld', 15:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:13 INFO - 'MOZ_NO_REMOTE': '1', 15:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:13 INFO - 'NO_EM_RESTART': '1', 15:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:13 INFO - 'PWD': '/builds/slave/test', 15:04:13 INFO - 'SHELL': '/bin/bash', 15:04:13 INFO - 'SHLVL': '1', 15:04:13 INFO - 'TERM': 'linux', 15:04:13 INFO - 'TMOUT': '86400', 15:04:13 INFO - 'USER': 'cltbld', 15:04:13 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:13 INFO - '_': '/tools/buildbot/bin/python'} 15:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:14 INFO - Downloading/unpacking psutil>=0.7.1 15:04:14 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 15:04:14 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 15:04:14 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 15:04:14 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 15:04:14 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 15:04:14 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 15:04:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:04:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:04:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:04:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:04:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:04:15 INFO - Installing collected packages: psutil 15:04:15 INFO - Running setup.py install for psutil 15:04:16 INFO - building 'psutil._psutil_linux' extension 15:04:16 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 15:04:16 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 15:04:16 INFO - building 'psutil._psutil_posix' extension 15:04:16 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 15:04:16 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 15:04:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:04:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:04:16 INFO - Successfully installed psutil 15:04:16 INFO - Cleaning up... 15:04:16 INFO - Return code: 0 15:04:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:16 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:16 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 15:04:16 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 15:04:16 INFO - Using env: {'DISPLAY': ':0', 15:04:16 INFO - 'HOME': '/home/cltbld', 15:04:16 INFO - 'LANG': 'en_US.UTF-8', 15:04:16 INFO - 'LANGUAGE': 'en_US:en', 15:04:16 INFO - 'LOGNAME': 'cltbld', 15:04:16 INFO - 'MAIL': '/var/mail/cltbld', 15:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:16 INFO - 'MOZ_NO_REMOTE': '1', 15:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:16 INFO - 'NO_EM_RESTART': '1', 15:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:16 INFO - 'PWD': '/builds/slave/test', 15:04:16 INFO - 'SHELL': '/bin/bash', 15:04:16 INFO - 'SHLVL': '1', 15:04:16 INFO - 'TERM': 'linux', 15:04:16 INFO - 'TMOUT': '86400', 15:04:16 INFO - 'USER': 'cltbld', 15:04:16 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:16 INFO - '_': '/tools/buildbot/bin/python'} 15:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:04:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:04:18 INFO - Installing collected packages: mozsystemmonitor 15:04:18 INFO - Running setup.py install for mozsystemmonitor 15:04:18 INFO - Successfully installed mozsystemmonitor 15:04:18 INFO - Cleaning up... 15:04:18 INFO - Return code: 0 15:04:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:18 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:18 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 15:04:18 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 15:04:18 INFO - Using env: {'DISPLAY': ':0', 15:04:18 INFO - 'HOME': '/home/cltbld', 15:04:18 INFO - 'LANG': 'en_US.UTF-8', 15:04:18 INFO - 'LANGUAGE': 'en_US:en', 15:04:18 INFO - 'LOGNAME': 'cltbld', 15:04:18 INFO - 'MAIL': '/var/mail/cltbld', 15:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:18 INFO - 'MOZ_NO_REMOTE': '1', 15:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:18 INFO - 'NO_EM_RESTART': '1', 15:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:18 INFO - 'PWD': '/builds/slave/test', 15:04:18 INFO - 'SHELL': '/bin/bash', 15:04:18 INFO - 'SHLVL': '1', 15:04:18 INFO - 'TERM': 'linux', 15:04:18 INFO - 'TMOUT': '86400', 15:04:18 INFO - 'USER': 'cltbld', 15:04:18 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:18 INFO - '_': '/tools/buildbot/bin/python'} 15:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:18 INFO - Downloading/unpacking blobuploader==1.2.4 15:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:20 INFO - Downloading blobuploader-1.2.4.tar.gz 15:04:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:04:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:04:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:04:21 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 15:04:21 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 15:04:21 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 15:04:21 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 15:04:21 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 15:04:21 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 15:04:21 INFO - Downloading docopt-0.6.1.tar.gz 15:04:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:04:21 INFO - Installing collected packages: blobuploader, requests, docopt 15:04:21 INFO - Running setup.py install for blobuploader 15:04:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:04:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:04:21 INFO - Running setup.py install for requests 15:04:21 INFO - Running setup.py install for docopt 15:04:21 INFO - Successfully installed blobuploader requests docopt 15:04:21 INFO - Cleaning up... 15:04:21 INFO - Return code: 0 15:04:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:21 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:21 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 15:04:21 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 15:04:21 INFO - Using env: {'DISPLAY': ':0', 15:04:21 INFO - 'HOME': '/home/cltbld', 15:04:21 INFO - 'LANG': 'en_US.UTF-8', 15:04:21 INFO - 'LANGUAGE': 'en_US:en', 15:04:21 INFO - 'LOGNAME': 'cltbld', 15:04:21 INFO - 'MAIL': '/var/mail/cltbld', 15:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:21 INFO - 'MOZ_NO_REMOTE': '1', 15:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:21 INFO - 'NO_EM_RESTART': '1', 15:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:21 INFO - 'PWD': '/builds/slave/test', 15:04:21 INFO - 'SHELL': '/bin/bash', 15:04:21 INFO - 'SHLVL': '1', 15:04:21 INFO - 'TERM': 'linux', 15:04:21 INFO - 'TMOUT': '86400', 15:04:21 INFO - 'USER': 'cltbld', 15:04:21 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:21 INFO - '_': '/tools/buildbot/bin/python'} 15:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:04:22 INFO - Running setup.py (path:/tmp/pip-TsPBe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:04:22 INFO - Running setup.py (path:/tmp/pip-lVNl7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:04:22 INFO - Running setup.py (path:/tmp/pip-kbQZkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:04:22 INFO - Running setup.py (path:/tmp/pip-ofo5xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:04:22 INFO - Running setup.py (path:/tmp/pip-6zi1P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:04:22 INFO - Running setup.py (path:/tmp/pip-5hgYgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:04:22 INFO - Running setup.py (path:/tmp/pip-WjDl0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:04:22 INFO - Running setup.py (path:/tmp/pip-JQLyNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:04:22 INFO - Running setup.py (path:/tmp/pip-W9fetV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:04:22 INFO - Running setup.py (path:/tmp/pip-lIFRjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:04:22 INFO - Running setup.py (path:/tmp/pip-1omkwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:04:22 INFO - Running setup.py (path:/tmp/pip-Xbc_Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:04:22 INFO - Running setup.py (path:/tmp/pip-ZsOZBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:04:23 INFO - Running setup.py (path:/tmp/pip-Wahp3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:04:23 INFO - Running setup.py (path:/tmp/pip-GWaAfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:04:23 INFO - Running setup.py (path:/tmp/pip-dA4dN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:04:23 INFO - Running setup.py (path:/tmp/pip-zB6Fne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:04:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:04:23 INFO - Running setup.py install for manifestparser 15:04:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:04:23 INFO - Running setup.py install for mozcrash 15:04:23 INFO - Running setup.py install for mozdebug 15:04:23 INFO - Running setup.py install for mozdevice 15:04:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:04:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:04:23 INFO - Running setup.py install for mozfile 15:04:23 INFO - Running setup.py install for mozhttpd 15:04:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:04:23 INFO - Running setup.py install for mozinfo 15:04:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Running setup.py install for mozInstall 15:04:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Running setup.py install for mozleak 15:04:24 INFO - Running setup.py install for mozlog 15:04:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Running setup.py install for moznetwork 15:04:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Running setup.py install for mozprocess 15:04:24 INFO - Running setup.py install for mozprofile 15:04:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Running setup.py install for mozrunner 15:04:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:04:24 INFO - Running setup.py install for mozscreenshot 15:04:24 INFO - Running setup.py install for moztest 15:04:25 INFO - Running setup.py install for mozversion 15:04:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:04:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:04:25 INFO - Cleaning up... 15:04:25 INFO - Return code: 0 15:04:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:25 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:25 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 15:04:25 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 15:04:25 INFO - Using env: {'DISPLAY': ':0', 15:04:25 INFO - 'HOME': '/home/cltbld', 15:04:25 INFO - 'LANG': 'en_US.UTF-8', 15:04:25 INFO - 'LANGUAGE': 'en_US:en', 15:04:25 INFO - 'LOGNAME': 'cltbld', 15:04:25 INFO - 'MAIL': '/var/mail/cltbld', 15:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:25 INFO - 'MOZ_NO_REMOTE': '1', 15:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:25 INFO - 'NO_EM_RESTART': '1', 15:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:25 INFO - 'PWD': '/builds/slave/test', 15:04:25 INFO - 'SHELL': '/bin/bash', 15:04:25 INFO - 'SHLVL': '1', 15:04:25 INFO - 'TERM': 'linux', 15:04:25 INFO - 'TMOUT': '86400', 15:04:25 INFO - 'USER': 'cltbld', 15:04:25 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:25 INFO - '_': '/tools/buildbot/bin/python'} 15:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:04:25 INFO - Running setup.py (path:/tmp/pip-Ws1Qw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:04:25 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)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:04:25 INFO - Running setup.py (path:/tmp/pip-3LtjX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:04:25 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)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:04:25 INFO - Running setup.py (path:/tmp/pip-SHaZeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:04:25 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)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:04:25 INFO - Running setup.py (path:/tmp/pip-Sjj6n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:04:25 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)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:04:25 INFO - Running setup.py (path:/tmp/pip-CcRJqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:04:25 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)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:04:25 INFO - Running setup.py (path:/tmp/pip-Cvtkyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:04:25 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)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:04:25 INFO - Running setup.py (path:/tmp/pip-c0k1U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:04:25 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)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:04:25 INFO - Running setup.py (path:/tmp/pip-K7Xz7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:04:25 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)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:04:25 INFO - Running setup.py (path:/tmp/pip-nmKVt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:04:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:04:25 INFO - Running setup.py (path:/tmp/pip-QBDHhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:04:26 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)) 15:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:04:26 INFO - Running setup.py (path:/tmp/pip-N3YktP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:04:26 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)) 15:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:04:26 INFO - Running setup.py (path:/tmp/pip-6bT8DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:04:26 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)) 15:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:04:26 INFO - Running setup.py (path:/tmp/pip-NeR91A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:04:26 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)) 15:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:04:26 INFO - Running setup.py (path:/tmp/pip-KrF9Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:04:26 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)) 15:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:04:26 INFO - Running setup.py (path:/tmp/pip-rBDyuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:04:26 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)) 15:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:04:26 INFO - Running setup.py (path:/tmp/pip-_i3HqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:04:26 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)) 15:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:04:26 INFO - Running setup.py (path:/tmp/pip-VPGeAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:04:26 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)) 15:04:26 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)) 15:04:26 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)) 15:04:26 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)) 15:04:26 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)) 15:04:26 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)) 15:04:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:28 INFO - Downloading blessings-1.5.1.tar.gz 15:04:28 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 15:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:04:28 INFO - Installing collected packages: blessings 15:04:28 INFO - Running setup.py install for blessings 15:04:28 INFO - Successfully installed blessings 15:04:28 INFO - Cleaning up... 15:04:28 INFO - Return code: 0 15:04:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:04:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:04:28 INFO - Reading from file tmpfile_stdout 15:04:28 INFO - Current package versions: 15:04:28 INFO - argparse == 1.2.1 15:04:28 INFO - blessings == 1.5.1 15:04:28 INFO - blobuploader == 1.2.4 15:04:28 INFO - docopt == 0.6.1 15:04:28 INFO - manifestparser == 1.1 15:04:28 INFO - mozInstall == 1.12 15:04:28 INFO - mozcrash == 0.16 15:04:28 INFO - mozdebug == 0.1 15:04:28 INFO - mozdevice == 0.47 15:04:28 INFO - mozfile == 1.2 15:04:28 INFO - mozhttpd == 0.7 15:04:28 INFO - mozinfo == 0.9 15:04:28 INFO - mozleak == 0.1 15:04:28 INFO - mozlog == 3.1 15:04:28 INFO - moznetwork == 0.27 15:04:28 INFO - mozprocess == 0.22 15:04:28 INFO - mozprofile == 0.28 15:04:28 INFO - mozrunner == 6.11 15:04:28 INFO - mozscreenshot == 0.1 15:04:28 INFO - mozsystemmonitor == 0.0 15:04:28 INFO - moztest == 0.7 15:04:28 INFO - mozversion == 1.4 15:04:28 INFO - psutil == 3.1.1 15:04:28 INFO - requests == 1.2.3 15:04:28 INFO - wsgiref == 0.1.2 15:04:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:28 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:28 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 15:04:28 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 15:04:28 INFO - Using env: {'DISPLAY': ':0', 15:04:28 INFO - 'HOME': '/home/cltbld', 15:04:28 INFO - 'LANG': 'en_US.UTF-8', 15:04:28 INFO - 'LANGUAGE': 'en_US:en', 15:04:28 INFO - 'LOGNAME': 'cltbld', 15:04:28 INFO - 'MAIL': '/var/mail/cltbld', 15:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:28 INFO - 'MOZ_NO_REMOTE': '1', 15:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:28 INFO - 'NO_EM_RESTART': '1', 15:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:28 INFO - 'PWD': '/builds/slave/test', 15:04:28 INFO - 'SHELL': '/bin/bash', 15:04:28 INFO - 'SHLVL': '1', 15:04:28 INFO - 'TERM': 'linux', 15:04:28 INFO - 'TMOUT': '86400', 15:04:28 INFO - 'USER': 'cltbld', 15:04:28 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:28 INFO - '_': '/tools/buildbot/bin/python'} 15:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 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)) 15:04:28 INFO - Cleaning up... 15:04:28 INFO - Return code: 0 15:04:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:28 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:28 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 15:04:28 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 15:04:28 INFO - Using env: {'DISPLAY': ':0', 15:04:28 INFO - 'HOME': '/home/cltbld', 15:04:28 INFO - 'LANG': 'en_US.UTF-8', 15:04:28 INFO - 'LANGUAGE': 'en_US:en', 15:04:28 INFO - 'LOGNAME': 'cltbld', 15:04:28 INFO - 'MAIL': '/var/mail/cltbld', 15:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:28 INFO - 'MOZ_NO_REMOTE': '1', 15:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:28 INFO - 'NO_EM_RESTART': '1', 15:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:28 INFO - 'PWD': '/builds/slave/test', 15:04:28 INFO - 'SHELL': '/bin/bash', 15:04:28 INFO - 'SHLVL': '1', 15:04:28 INFO - 'TERM': 'linux', 15:04:28 INFO - 'TMOUT': '86400', 15:04:28 INFO - 'USER': 'cltbld', 15:04:28 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:28 INFO - '_': '/tools/buildbot/bin/python'} 15:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:29 INFO - Downloading/unpacking jsonschema 15:04:29 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 15:04:29 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 15:04:29 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 15:04:29 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 15:04:29 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 15:04:29 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 15:04:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:04:30 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 15:04:30 INFO - Downloading/unpacking functools32 (from jsonschema) 15:04:30 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 15:04:30 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 15:04:30 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 15:04:30 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 15:04:30 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 15:04:30 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 15:04:31 INFO - Downloading functools32-3.2.3-2.tar.gz 15:04:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:04:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:04:31 INFO - warning: no files found matching '*.txt' 15:04:31 INFO - no previously-included directories found matching 'build' 15:04:31 INFO - no previously-included directories found matching 'dist' 15:04:31 INFO - no previously-included directories found matching '.git*' 15:04:31 INFO - Installing collected packages: jsonschema, functools32 15:04:31 INFO - Running setup.py install for functools32 15:04:31 INFO - warning: no files found matching '*.txt' 15:04:31 INFO - no previously-included directories found matching 'build' 15:04:31 INFO - no previously-included directories found matching 'dist' 15:04:31 INFO - no previously-included directories found matching '.git*' 15:04:31 INFO - Successfully installed jsonschema functools32 15:04:31 INFO - Cleaning up... 15:04:31 INFO - Return code: 0 15:04:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:31 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 0x7f592d0b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1885dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, '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': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', '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 15:04:31 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 15:04:31 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 15:04:31 INFO - Using env: {'DISPLAY': ':0', 15:04:31 INFO - 'HOME': '/home/cltbld', 15:04:31 INFO - 'LANG': 'en_US.UTF-8', 15:04:31 INFO - 'LANGUAGE': 'en_US:en', 15:04:31 INFO - 'LOGNAME': 'cltbld', 15:04:31 INFO - 'MAIL': '/var/mail/cltbld', 15:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:31 INFO - 'MOZ_NO_REMOTE': '1', 15:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:31 INFO - 'NO_EM_RESTART': '1', 15:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:31 INFO - 'PWD': '/builds/slave/test', 15:04:31 INFO - 'SHELL': '/bin/bash', 15:04:31 INFO - 'SHLVL': '1', 15:04:31 INFO - 'TERM': 'linux', 15:04:31 INFO - 'TMOUT': '86400', 15:04:31 INFO - 'USER': 'cltbld', 15:04:31 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:31 INFO - '_': '/tools/buildbot/bin/python'} 15:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:31 INFO - Downloading/unpacking flake8 15:04:31 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 15:04:31 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 15:04:31 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 15:04:31 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 15:04:31 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 15:04:31 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 15:04:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:04:33 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 15:04:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:04:33 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 15:04:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 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 15:04:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:04:34 INFO - no previously-included directories found matching 'docs/_build' 15:04:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:04:34 INFO - Running setup.py install for pep8 15:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:04:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:04:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:04:34 INFO - no previously-included directories found matching 'docs/_build' 15:04:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:04:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:04:34 INFO - Cleaning up... 15:04:34 INFO - Return code: 0 15:04:34 INFO - Running post-action listener: _resource_record_post_action 15:04:34 INFO - Running post-action listener: _start_resource_monitoring 15:04:34 INFO - Starting resource monitoring. 15:04:34 INFO - ##### 15:04:34 INFO - ##### Running install step. 15:04:34 INFO - ##### 15:04:34 INFO - Running pre-action listener: _resource_record_pre_action 15:04:34 INFO - Running main action method: install 15:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:04:34 INFO - Reading from file tmpfile_stdout 15:04:34 INFO - Detecting whether we're running mozinstall >=1.0... 15:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:04:34 INFO - Reading from file tmpfile_stdout 15:04:34 INFO - Output received: 15:04:34 INFO - Usage: mozinstall [options] installer 15:04:34 INFO - Options: 15:04:34 INFO - -h, --help show this help message and exit 15:04:34 INFO - -d DEST, --destination=DEST 15:04:34 INFO - Directory to install application into. [default: 15:04:34 INFO - "/builds/slave/test"] 15:04:34 INFO - --app=APP Application being installed. [default: firefox] 15:04:34 INFO - mkdir: /builds/slave/test/build/application 15:04:34 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'] 15:04:34 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 15:04:50 INFO - Reading from file tmpfile_stdout 15:04:50 INFO - Output received: 15:04:50 INFO - /builds/slave/test/build/application/firefox/firefox 15:04:50 INFO - Running post-action listener: _resource_record_post_action 15:04:50 INFO - ##### 15:04:50 INFO - ##### Running run-tests step. 15:04:50 INFO - ##### 15:04:50 INFO - Running pre-action listener: _resource_record_pre_action 15:04:50 INFO - Running main action method: run_tests 15:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:04:50 INFO - Python 2.7.3 15:04:50 INFO - Return code: 0 15:04:50 INFO - grabbing minidump binary from tooltool 15:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:50 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 0x19183d0>, '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 0x1883ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1884360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:04:50 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 15:04:50 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 15:04:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:04:50 INFO - Return code: 0 15:04:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:04:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:04:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:04:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:04:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:04:51 INFO - Return code: 0 15:04:51 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/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 15:04:51 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/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 15:04:51 INFO - Using env: {'DISPLAY': ':0', 15:04:51 INFO - 'HOME': '/home/cltbld', 15:04:51 INFO - 'LANG': 'en_US.UTF-8', 15:04:51 INFO - 'LANGUAGE': 'en_US:en', 15:04:51 INFO - 'LOGNAME': 'cltbld', 15:04:51 INFO - 'MAIL': '/var/mail/cltbld', 15:04:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:04:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:51 INFO - 'MOZ_NO_REMOTE': '1', 15:04:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:51 INFO - 'NO_EM_RESTART': '1', 15:04:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:51 INFO - 'PWD': '/builds/slave/test', 15:04:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:04:51 INFO - 'SHELL': '/bin/bash', 15:04:51 INFO - 'SHLVL': '1', 15:04:51 INFO - 'TERM': 'linux', 15:04:51 INFO - 'TMOUT': '86400', 15:04:51 INFO - 'USER': 'cltbld', 15:04:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461', 15:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:51 INFO - '_': '/tools/buildbot/bin/python'} 15:04:51 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/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 15:04:51 INFO - mozversion application_buildid: 20160109142731 15:04:51 INFO - mozversion application_changeset: af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c 15:04:51 INFO - mozversion application_display_name: Nightly 15:04:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:04:51 INFO - mozversion application_name: Firefox 15:04:51 INFO - mozversion application_remotingname: firefox 15:04:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:04:51 INFO - mozversion application_vendor: Mozilla 15:04:51 INFO - mozversion application_version: 46.0a1 15:04:51 INFO - mozversion platform_buildid: 20160109142731 15:04:51 INFO - mozversion platform_changeset: af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c 15:04:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:04:51 INFO - mozversion platform_version: 46.0a1 15:04:51 INFO - using testdate: 1452380691 15:04:51 INFO - actual date: 1452380691 15:04:51 INFO - starting webserver on 'localhost:44376' 15:04:51 INFO - SUITE-START | Running 3 tests 15:04:51 INFO - TEST-START | dromaeo_css 15:04:51 INFO - operating with platform_type : linux_ 15:04:51 INFO - Initialising browser for dromaeo_css test... 15:04:51 INFO - TEST-INFO | started process 12382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdunOoW/profile http://localhost:44376/getInfo.html) 15:04:55 INFO - PROCESS | 12382 | 15:04:55 INFO - PROCESS | 12382 | (process:12462): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:04:55 INFO - PROCESS | 12382 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:04:55 INFO - PROCESS | 12382 | __metrics Screen width/height:1600/1200 15:04:55 INFO - PROCESS | 12382 | colorDepth:24 15:04:55 INFO - PROCESS | 12382 | Browser inner width/height: 1024/697 15:04:55 INFO - PROCESS | 12382 | __metrics 15:04:56 INFO - PROCESS | 12382 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:04:57 INFO - TEST-INFO | 12382: exit 0 15:04:57 INFO - Browser initialized. 15:04:57 INFO - Running cycle 1/1 for dromaeo_css test... 15:04:57 INFO - TEST-INFO | started process 12511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdunOoW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:04:58 INFO - PROCESS | 12511 | 15:04:58 INFO - PROCESS | 12511 | (process:12566): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:05:09 INFO - PROCESS | 12511 | RSS: Main: 151285760 15:05:09 INFO - PROCESS | 12511 | 15:05:58 INFO - PROCESS | 12511 | 1452380758791 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] 15:08:10 INFO - PROCESS | 12511 | Cycle 1(1): loaded http://localhost:44376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44376/tests/dromaeo/cssquery-ext.html) 15:08:11 INFO - PROCESS | 12511 | RSS: Main: 154562560 15:08:11 INFO - PROCESS | 12511 | 15:11:13 INFO - PROCESS | 12511 | Cycle 1(1): loaded http://localhost:44376/tests/dromaeo/cssquery-ext.html (next: http://localhost:44376/tests/dromaeo/cssquery-jquery.html) 15:11:14 INFO - PROCESS | 12511 | RSS: Main: 152453120 15:11:14 INFO - PROCESS | 12511 | 15:14:16 INFO - PROCESS | 12511 | Cycle 1(1): loaded http://localhost:44376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44376/tests/dromaeo/cssquery-mootools.html) 15:14:16 INFO - PROCESS | 12511 | RSS: Main: 153468928 15:14:16 INFO - PROCESS | 12511 | 15:17:18 INFO - PROCESS | 12511 | Cycle 1(1): loaded http://localhost:44376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44376/tests/dromaeo/cssquery-prototype.html) 15:17:19 INFO - PROCESS | 12511 | RSS: Main: 152522752 15:17:19 INFO - PROCESS | 12511 | 15:20:21 INFO - PROCESS | 12511 | Cycle 1(1): loaded http://localhost:44376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44376/tests/dromaeo/cssquery-yui.html) 15:20:22 INFO - PROCESS | 12511 | RSS: Main: 153530368 15:20:22 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | Cycle 1(1): loaded http://localhost:44376/tests/dromaeo/cssquery-yui.html (next: http://localhost:44376/tests/dromaeo/cssquery-dojo.html) 15:23:24 INFO - PROCESS | 12511 | RSS: Main: 155172864 15:23:24 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | __start_tp_report 15:23:24 INFO - PROCESS | 12511 | _x_x_mozilla_page_load 15:23:24 INFO - PROCESS | 12511 | _x_x_mozilla_page_load_details 15:23:24 INFO - PROCESS | 12511 | |i|pagename|runs| 15:23:24 INFO - PROCESS | 12511 | |0;dojo.html;2644.0349272515527;2688.690800557934;2731.0577850641534;2740.356016336161;2757.5312196926525;4521.90956180877;4610.216263235246;4641.976790116053;4653.837115700947;4661.790219440125;4566.862994110182;4595.885102872421;4607.05555361151;4704;4715.85852424427;4231.640310573605;4250.06498570314;4265.424167737347;4302.548232435596;4328.848490302824;4284.507281662618;4319.049809042006;4322.438083049199;4384.693071484981;4404.559544045585;4145.129522800185;4232.343986682038;4243.130158317537;4330.913381732379;4334.371516130159;4181.226473102486;4278.379634952915;4297.462817147856;4308.2675945089095;4319.308910574293;4186.099988502487;4191.245575796355;4197.958020419787;4199.895002624959;4220.2192594370135;4309.095090031097;4465.933011004838;4469.374287599739;4487.528809475023;4563.498015218323;4991.5258050485145;4996.675216110941;4999.975000125012;5011.2483127530795;5029.321041659366;5031.421386540558;5034.395872495324;5034.697918124888;5042.193249080166;5078.568321692661;4495.1683938471815;4599.862004139881;4603.434832157082;4713.905721885578;4715.457722361973;5040.941402305483;5063.367079115111;5083.517065878736;5088.9745551272745;5100.413452452941;4894.216925291937;4900.852974410774;4907.214845624683;4910.116179087727;4942.728149951715;4804.8318308859025;4903.313536104948;4980.103581355318;5039.042581909425;5068.569171620454;4913.926291105637;4949.307097006422;4957.058158949788;4963.45402005779;5007.349044624249;4751.4535828379485;4887.169181239198;4923.507649235119;4937.654364194472;4965.950340496621;4060.918781624351;4085.5914408558906;4150.584941505826;4163.188178305262;4177.373393990925;3617.330793803102;3618.927621447609;3632.7093832493338;3655.1593133579427;3671.724620653462;4152.273352163359;4235.407043013981;4253.361995700608;4254.574542545721;4256.1487702459635;4893.853184404474;4975.751212439363;4976.154053810861;4978.32792572998;5020.623453241022;4282.357646353072;4282.892927676833;4301.44081269433;4317.222899877989;4347;4304.4834619845815;4366.388705581221;4399.62603178727;4407.427034485497;4433.578810013044;4776.689515181502;4785.760711964318;4788.880277992938;4795.064962332382;4800.927986080282;5016.046951079284;5017.598592112695;5018.021485810232;5025.3718285214345;5079.136546786981;4582.358469814162;4682.204025315773;4689.671722979495;4773.570378665937;4808.495108013748;4868.951310486991;4884.755762211947;4888.902221955612;4903.141950158637;4929.112759703288;4962.528559786814;4990.525900039491;4999.925001124913;5003.149464590955;5036.169032109661;4643.535646435329;4799.088173247072;4811.350467686958;4872.366592342973;4894.412670479423;4816.95183048179;4824.131656301899;4832.806687732592;4849.515048495264;4882.267659851051;4582.587567118975;4736.692115012514;4740.976295118502;4765.0946320199055;4770.308305295782;4809.422869255712;4836.347093142522;4922.212446008622;4923.532264434873;4946.455889852042;4733.928991065206;4771.785269662804;4803.855884323476;4804.375431194062;4855.854324370274 15:23:24 INFO - PROCESS | 12511 | |1;ext.html;483.25096101043374;517.8135871086411;519.5557798082639;525.7318767428611;541.8184908055802;31111.844440777793;31350.216244593896;31759.206019849487;31941.52087718686;31945.36109277813;31861.203469913264;32647.347053058926;32676.83661581695;32683.836580817122;32719.1820204495;7411.518251313661;7592.240775922419;7593.582352970584;7596.696132154735;7599.012128423297;7326.377257933082;7584.3174114329695;7615.428842836782;7623.313901748841;7627.7330293439745;7556.319931206191;7649.579273139975;7685.846283074336;7690.115636701795;7700.499467534592;7508.061492313461;7535.095788505359;7616.581088040183;7623.809404764897;7630.160682324939;7543.471956963015;7646.808829779245;7652.196519365498;7661.463697541174;7677.309042186174;33436.33127337464;33538.6646133538;33741.493877591856;33747.662523374696;33897.32205355904;2858;3163.225009872573;3208.4866421372467;3266.3957167923772;3302.94305822137;26723.46553068947;26839.19482415511;27192.72807271922;27264.45471090587;27759.444811103866;3241.594800649919;3242.5136229565755;3274.099622603779;3296.538484612156;3336.6830151135605;211799;212073;212534;213594;213653;44402.55597444049;45756.77121614437;51000.489995099575;51618.483815161366;51620.74189629028;46607.766961164976;46627.30059049117;46678.533214668096;46777.064458710636;46899.29651055237;12193.085518586142;12229.14395992272;12273.815892761615;12285.754284914252;12292.139550231577;9618.711438656852;9731.756706082262;9747.463889486004;9773.560189791477;9838.901610983941;16720.916395417946;17007.744883826752;17822.019788911733;17935.73096403555;17971.550711232325;6831.69257383419;6940.444764418834;7011.964940175369;7016.228214896358;7054.6825392857445;817.513579420244;832.4589017138908;854.6495936665937;879.7976465412863;944.4003058058182;26193.476130477284;27195.592066119025;27732;27855.860720696266;27932.44135117327;938.4369378372921;977.941323520591;978.9118979291898;988.2242439684813;1027.157730660851;13354;13847.446102156002;13977.79033314501;14290.857091429161;14712.19082950448;249723;254551;255890;255998;257132;44713;44953.55046449494;45082.774586126856;45086.32370514445;45215.96528156241;1232.2236990695803;1232.4146030635377;1265.2787910890704;1267.8922291605131;1342.6576223063057;25520.74479255258;25894.741052589234;25978;26036;26122.738772612793;37841.05397365088;38187.2362552753;38287.42568861525;38326.23347532978;38354.23291534098;198430;198711.08377955385;198715;245266;245807;24290.08518977734;24807.379815504755;26491.337716557242;28071.859640701667;28260.152195433348;33186.50220246746;33333.333333333685;33541.496877547346;33660.158496037795;33942.490862637576;28335.716642834133;28583.42833143284;28729.71270287354;28818.135455936357;29554.261143471584;28119.71880281171;28261.717382825907;28283.15150545487;28339.858300708365;28978.27554311159;31051.378972420876;31294.374112517165;31446.213844654067;31849.6815031856;34528.82735586306;28054.158375248775;28899.7110028897;29042;29054.7094529052;29306.681199345654;22916.541669166858;22984.195553155558;23201.955911983663;23219.88390058039;23240.76759232386 15:23:24 INFO - PROCESS | 12511 | |2;jquery.html;317.5300555178336;319.162199227029;321.847122616757;323.20007980248886;330.9106541233867;14532.63668408289;14800;14963.551093467186;15057.472988445406;15648.452304169356;9979.451130187837;10283.382997020184;12555.435005424755;15341.156236406992;15346.616334591641;4386.0789234260765;4470.530594287602;4579.656525760582;5023.447420783729;5049.64652474327;4996.400431948153;5075.670081444713;5078.619103567229;5080.745962701869;5087.440381558025;5037.949620503785;5833.504152147073;5950.077737950624;6224.8132556023165;6239.9688001559925;5211.348581427322;6058.909116363236;6149.13912052313;6528.869422611521;6542.116814230066;6200.410960958701;6267.62394256346;6280.120783090371;6288.685565721696;6289.937100629027;19265.229390824352;19451.90274048635;19846.70229946552;20543.4864128398;20544.38366848982;1773.5832079461316;1840.402588066142;1845.9077046147638;1887.0736942523258;1898.1078892920304;13201.933990330082;13218.86781132186;13274.734505309936;13510.189388636712;13570.93214533921;1838.1452624529659;1871.354382737967;1875.1374367790831;1927.5566619677413;1939.7187407825927;56621.716891415694;57707.99999999958;58133.70933145307;58201.7089914552;58204.417955820325;14432.639184020483;14703.214552703714;14719.337629806685;14745.631359216106;14838.629034274014;21524.892375538024;21659.35021949344;21815;21851.672224916638;22191.334259971904;8715.738527844174;8822.647094116292;8887.555622218862;8979.595918183566;8984.416012959136;7148.678309476086;7214.458915581353;7221.783346499614;7491.962540187374;7530.548167109881;7071.964640176869;7214.422846172293;7219.169795473483;7259.673314700851;7280.271972802678;1697.2786565709523;1745.4065617689791;2849.871755770995;3043.6195475565555;3074;726.6520604278986;756.3911051603512;820.2692319206469;838.576518857985;934.9859752103724;14867.91293010705;14976.550703478913;15336.15651139198;15409.691806163813;15597.922010390103;689.3830022130165;802.3581135091903;844.4251471006651;853.0914575976565;874.6719980007497;8671.653133874574;8808.20726134651;8829.381943264038;8886.183202678718;8961.820763584692;430376;437259;438356;440751;447458;64476;65189.348106519275;65995.67002164958;66436;66763.33236667668;976.7118699983522;1050.5062620568322;1102.2614848051824;1113.0316624536704;1114.9665510034713;13043.347832608142;13501.527446539323;13519.459221631025;13728.725425491633;14014.649633759238;27091.458170836868;27273.31816704598;27484.58773118365;27587;28359.29101772472;32188.839055804572;32757.181070472474;33006.834965825015;34429.82785086059;37724.81137594295;6174.567780255339;6431.48548116159;6499.350064993463;6511.837204069936;6621.900671490028;8000.319972802145;9709.805803884024;9753;9772.26707996889;9778.804423911624;2625.9474810504066;2661.8136730428682;5377.763114483612;7518.188763663472;8534.274586659954;8648.567571621268;8934.553272336227;8965.59654815548;9056.13966673165;9126.49804260772;7051.647417628996;8756.912430875609;9122.179003889682;9163.358564900393;9181.071974885348;6594.769183078569;6836.487263455161;6893.862122757417;6963.93036069653;7124.3944264738075;7715.4599178057;7831.490953088031;8264.710735124241;9135.26917846584;9137.223336016514 15:23:24 INFO - PROCESS | 12511 | |3;mootools.html;1388.7083712420392;1401.9018668693193;1526.6336079340954;1709.102721071438;1730.5846596816768;7091.751788687397;7263.818404539889;7288.708451661933;7460.701571937123;7474.5141565798185;7225.349718525332;7248.891266631004;7315.085614298213;7316.0489136412325;7331.0469638947;2138.6791981202828;2151.5481748832763;2159.147136880939;2159.427751645815;2164.7077644518026;2178.8039076483115;2192.2984644913636;2252.2680128958073;2254.4476603232233;2257.221258665758;1737.6177241007022;1771.2118107442193;2084.1038353507984;2174.8803815790125;2195.769444208359;2136.3590922723197;2141.3575927221927;2144.8176904963098;2147.5168087180414;2148.3877095027997;2096.2872623307994;2141.1328411993168;2153.7953894380007;2157.7950094740972;2161.7730138335405;7366.521176123535;7488.213737557532;7525.322720955086;7526.586037767921;7531.397488200985;4346.521882592912;4443.311286750559;4499.280115181588;4504.256797628387;4506.571875671806;3009.7893147479685;3010.698930106994;3081.6918308169;3087.691230876917;3114.252579380955;861.5907443964129;877.1623099939543;882.6557642519423;885.1148851148852;907.4464576608264;9962.501874906298;10013.89986100137;10075.848862267072;10076.848847267296;10115.544800483996;3897.590752970954;3965.7422267552515;3966.861159859449;3974.5429275633674;4110.547839737626;8126.187381261945;8127.634256458474;8127.79680507992;8158.632861521246;8179.059408168017;4252.723572967809;4263.189993901149;4280.978595107004;4283.507396649363;4291.463567054118;3901.08324543732;3905.297046531595;3911.941320880189;3922.9607703922597;3925.9214815703526;3222.371637530706;3281.4585593376823;3300.950485742716;3314.0886256279714;3330.7168890644566;986.7763972673832;1001.7645853224486;1003.0320740485466;1004.0862814838462;1017.1252722658508;778.5640041576735;821.6056292979404;869.2741560796679;945.2013048973606;1109.328856042099;6705.798826035227;6884.208316043619;6898.448124150056;6922;6930.099087118743;554.2406902543461;565.2115299157653;585.1106318396099;585.745200837637;706.6219572528672;5192.636515443958;5202.76587553561;5204.531592156724;5206.8437946860895;5249.42256351801;8378.664853405795;9210.309226808016;9224.30817688676;9267.397619154734;9281.21109705669;9079.50062746542;9092.681756138503;9102.408343457653;9150.03924587922;9169.220616247694;6717.126773519509;6848.863022739517;6868.347506986828;6918.169819621577;7103.437243806355;6802.591844489149;6810.829729256809;6829.6585170742255;6831.11195544576;6879.58722476653;7697.499662521918;7962.761117166494;7967.123616402076;7992.920070799218;8104.108548059591;8129;8236.464629799044;8243.546604936786;8246.752597422086;8357.289630381485;6507.707153178213;6516.57642253252;6564.704588293443;6565.80302590923;6580.967095164685;6793.184817821893;6820.079289295882;6826.795196143925;6833.726650933907;6843.247242803387;6644.76743314001;6730.966345168243;6765.42493888025;6868.828279293058;6886;5367;6216.2540495140875;6264.185655864891;6354.618722876642;6699.29657385987;6134.601250918676;6147.84630384244;6187.907181392193;6301.96849015752;6472.417482426604;6115.510759139169;6142.201513803177;6149.046897730859;6158.476529495043;6204.875902481835;6296.0555916612875;6357.332480089709;6371.713272902638;6381.1704478417505;6382.712777924911 15:23:24 INFO - PROCESS | 12511 | |4;prototype.html;297.9731824135828;307.9876804927802;310.5683100490319;316.23855126942925;320.7081555784234;5456;5541.168824676301;5553.888922221553;5613.270274864262;5618.988582055239;5527.281453411061;5528.55771538277;5565.916511252334;5599.804006859761;5600.2719646446;4098.774567398792;4245.150969806035;4321.070969741505;4327.4157988671595;4336.76147811871;4215.789210539476;4318.4817821861425;4341.6092551670345;4344.500382456011;4346.282863327548;4269.893252668677;4273.423087883142;4295.355696645513;4303.7848107594655;4307.0955099429;4300.720453170549;4313.266744653416;4314.072474418;4317.050248945227;4323.481182258118;3797.2405518896053;3802.2205447883116;3804.106035081781;3807.9238415231816;3815.313243616148;5215.530602245816;5334.5732341412595;5348.304720386363;5358.517733404013;5359.705216213107;4962.751862406865;4964.67729597575;4971.105201063807;4972.328735620681;4979.07887040895;5839.503642190419;5841.795537156222;5842.006858834008;5842.620229685057;5846.386129456431;4040.393940908858;4131.628153466202;4137.40007698885;4139.958600414017;4143.233501802176;6138.202033735631;6143.754249830002;6144.662043587601;6147.72335244915;6153.630782153085;4266.8293268269545;4274.059706864485;4274.764887931194;4279.037216626234;4284.935725964113;4337;4339.1104823511105;4342.435483387139;4343.283358245854;4348.173846969065;4811.591014763714;4936.679115857458;4941.827036053793;4944.9258261126115;4953.2074868020945;5805.651660900359;5859.296884373903;5866.8533286667325;5866.882662346729;5868.207791948118;1529.587011506887;1542.4138827245574;1547.6440418703762;1553.30101454346;1553.324303927795;1061.9787604248027;1065.3288428290127;1070.9036186743074;1071.8660167479065;1088.374184843718;5063.240513922941;5084;5094.668846525038;5096.286519887219;5110.97444512775;5948.196993405922;6084.452399283997;6148.200733904564;6158.599691020069;6162.938370616326;5110.207917772676;5112.233165025276;5115.309433226466;5121.359830021247;5127.282180494733;3235.530848027023;3301.422251106095;3305.190228394011;3308.8511017004294;3310.155910242873;5685.886282274414;5793.333766616809;5795.82612521625;5797.88404231913;5811.360750317462;6280.057991301342;6287.528435367274;6292.905606415908;6297.055441683692;6305.054241863757;5803.303603567514;5804.100364443433;5804.883902322014;5805.912911306334;5808.535317174616;5939.4357536034;6119.388061193845;6124.418180272867;6126.6017708848785;6156.5998210116195;5938.168656388023;5981.312149102909;5986.2517185351835;5992.670403127696;6003.729832157651;5782.566307527037;5794.0439827428;5798.478136967693;5802.216700745345;5814.76740930358;4145.191687620885;4181.853635122756;4186.434831297857;4194.937075943924;4203.222403855297;5993.850153746017;6130.080487926668;6131.877362452637;6133.141360209485;6142.938570614237;5894.793682221101;5900.64596124234;5901.911471327848;5904.084866845646;5906.114082887601;5875.618084824644;5878.500327472213;5880.470757631662;5893;5896;5658.651718542687;5727.1695604138;5763;5771.624844385102;5780.21967034445;5907.172995780508;5915.37888521699;5917.881642367042;5918.526517878646;5933.762649493972;5594.496495315441;5742.224799651994;5742.569307301886;5747.5401967841635;5765.654060756368 15:23:24 INFO - PROCESS | 12511 | |5;yui.html;750.500916890268;767.3592550220566;784.1178673991759;790.4980337485695;805.0741647105824;10616.363018218912;10742.462876856156;10750.193735469851;10770.78458430832;10780.299280546758;10298.382097074162;10315.53580088896;10352.275340726133;10386.792264154712;10740.409277489734;756.0624825216732;772.563501621582;774.8605251054807;775.5346791924828;776.119104816035;774.1136398823344;775.51917810957;776.6116941529235;777.4518964130275;778.9415793815458;805.0942689474341;810.84999275134;813.353384059674;813.8535063688533;815.824597711492;801.8115742800408;804.4931693033352;805.2712295372697;808.8827120067557;809.1746418652971;595.4462350014485;596.6956852005464;600.771706751436;600.780715039012;603;10488.160947124288;10543.314684545558;10558.68323950275;10569.841452378221;10620.628278010232;9757.219422446187;9888.703338899844;9931.60217918641;9960.601575936953;9983.650572229937;8325.708600199025;8358.832823343499;8390.664373425056;8420.8315833683;8480.957595212047;3073.523603841408;3117.0960421477744;3158.589383380169;3163.3040731039137;3198.1684761962056;36245.275094498225;36427.08932276688;37146.25707485862;37159.256814863824;37445.25109497822;9163.58763855628;9235.215006724504;9806.411615303105;9867.654632087842;9967.053129952643;16962.575935601708;17121.486355409357;17123.400680976356;17146;17164.742528862076;6508.8047358579315;6631;6650.53446258767;6657.434118099919;6700.698468568926;3611.4041183205004;3642.1076836175307;3642.34437801193;3674.9448758268645;3763.2701656910626;2691.138835572637;2711.417045335262;2715.3618899558587;2716.714744951791;2717.171262764876;489.7184119131514;494.8540180646718;505.623310633573;505.815377387251;506.29119233073993;546.4016901492859;565.4402141879592;575.602834044508;592.2862950145064;615.5321955313904;7264.709411623581;7480.551166930001;7500.399968002546;7700.614969251627;7774.961125194451;497.8382025841616;576.6136688418769;578.5082679722286;591.5754901766809;625.2247213455282;3419.863205471803;3437.9812700295493;3492.89521314361;3515.7538972271695;3545.8227088645463;47961;48204.758976204896;48423.273650895266;48612;48612.75693621509;41920.161596767895;42172.57827421748;42201;42443.36334954978;42487.36268955968;34294.48558271628;38984;39941;43650.563494365284;43804.56195438005;7531.548107113591;7897.526148431112;7912.68349266046;8160.102388737116;8302.6678932842;29412.411751764415;29942.754293427643;30785.8460707695;30843;31142.53286200754;32743.508847366833;33619.663803361655;33776.49335259924;33945.830270848484;33987.49018764671;9287.442753434816;9320.440773553608;9347.906520934703;9511.381760185843;9690.12788849007;10427.68716938493;10657.520411581343;10680.198985075995;10949.726256843323;11067.944660276647;10348.981948520268;10447.895521044693;10479.580816767244;10507.94746026265;10557.472126393803;10093.848592271268;10119.848202277119;10126.13927816144;10141.79716405653;10183.338083024875;9977.800443991226;10290.742731431774;10457;10474.371537707762;10487.632932847313;8081;8118.3099436548555;8360.70737524208;8450.577471126542;8623.8706419405;8745.693900713444;8841.60212790413;9003.919529656483;9015;9039.45763254207 15:23:24 INFO - PROCESS | 12511 | __end_tp_report 15:23:24 INFO - PROCESS | 12511 | __start_cc_report 15:23:24 INFO - PROCESS | 12511 | _x_x_mozilla_cycle_collect,329 15:23:24 INFO - PROCESS | 12511 | __end_cc_report 15:23:24 INFO - PROCESS | 12511 | __startTimestamp1452381804852__endTimestamp 15:23:24 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | ------- Summary: start ------- 15:23:24 INFO - PROCESS | 12511 | Number of tests: 6 15:23:24 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | [#0] dojo.html Cycles:165 Average:4587.08 Median:4740.98 stddev:478.55 (10.1%) stddev-sans-first:455.10 15:23:24 INFO - PROCESS | 12511 | Values: 2644.0 2688.7 2731.1 2740.4 2757.5 4521.9 4610.2 4642.0 4653.8 4661.8 4566.9 4595.9 4607.1 4704.0 4715.9 4231.6 4250.1 4265.4 4302.5 4328.8 4284.5 4319.0 4322.4 4384.7 4404.6 4145.1 4232.3 4243.1 4330.9 4334.4 4181.2 4278.4 4297.5 4308.3 4319.3 4186.1 4191.2 4198.0 4199.9 4220.2 4309.1 4465.9 4469.4 4487.5 4563.5 4991.5 4996.7 5000.0 5011.2 5029.3 5031.4 5034.4 5034.7 5042.2 5078.6 4495.2 4599.9 4603.4 4713.9 4715.5 5040.9 5063.4 5083.5 5089.0 5100.4 4894.2 4900.9 4907.2 4910.1 4942.7 4804.8 4903.3 4980.1 5039.0 5068.6 4913.9 4949.3 4957.1 4963.5 5007.3 4751.5 4887.2 4923.5 4937.7 4966.0 4060.9 4085.6 4150.6 4163.2 4177.4 3617.3 3618.9 3632.7 3655.2 3671.7 4152.3 4235.4 4253.4 4254.6 4256.1 4893.9 4975.8 4976.2 4978.3 5020.6 4282.4 4282.9 4301.4 4317.2 4347.0 4304.5 4366.4 4399.6 4407.4 4433.6 4776.7 4785.8 4788.9 4795.1 4800.9 5016.0 5017.6 5018.0 5025.4 5079.1 4582.4 4682.2 4689.7 4773.6 4808.5 4869.0 4884.8 4888.9 4903.1 4929.1 4962.5 4990.5 4999.9 5003.1 5036.2 4643.5 4799.1 4811.4 4872.4 4894.4 4817.0 4824.1 4832.8 4849.5 4882.3 4582.6 4736.7 4741.0 4765.1 4770.3 4809.4 4836.3 4922.2 4923.5 4946.5 4733.9 4771.8 4803.9 4804.4 4855.9 15:23:24 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | [#1] ext.html Cycles:180 Average:37542.65 Median:17944.93 stddev:59687.37 (332.6%) stddev-sans-first:59789.94 15:23:24 INFO - PROCESS | 12511 | Values: 483.3 517.8 519.6 525.7 541.8 31111.8 31350.2 31759.2 31941.5 31945.4 31861.2 32647.3 32676.8 32683.8 32719.2 7411.5 7592.2 7593.6 7596.7 7599.0 7326.4 7584.3 7615.4 7623.3 7627.7 7556.3 7649.6 7685.8 7690.1 7700.5 7508.1 7535.1 7616.6 7623.8 7630.2 7543.5 7646.8 7652.2 7661.5 7677.3 33436.3 33538.7 33741.5 33747.7 33897.3 2858.0 3163.2 3208.5 3266.4 3302.9 26723.5 26839.2 27192.7 27264.5 27759.4 3241.6 3242.5 3274.1 3296.5 3336.7 211799.0 212073.0 212534.0 213594.0 213653.0 44402.6 45756.8 51000.5 51618.5 51620.7 46607.8 46627.3 46678.5 46777.1 46899.3 12193.1 12229.1 12273.8 12285.8 12292.1 9618.7 9731.8 9747.5 9773.6 9838.9 16720.9 17007.7 17822.0 17935.7 17971.6 6831.7 6940.4 7012.0 7016.2 7054.7 817.5 832.5 854.6 879.8 944.4 26193.5 27195.6 27732.0 27855.9 27932.4 938.4 977.9 978.9 988.2 1027.2 13354.0 13847.4 13977.8 14290.9 14712.2 249723.0 254551.0 255890.0 255998.0 257132.0 44713.0 44953.6 45082.8 45086.3 45216.0 1232.2 1232.4 1265.3 1267.9 1342.7 25520.7 25894.7 25978.0 26036.0 26122.7 37841.1 38187.2 38287.4 38326.2 38354.2 198430.0 198711.1 198715.0 245266.0 245807.0 24290.1 24807.4 26491.3 28071.9 28260.2 33186.5 33333.3 33541.5 33660.2 33942.5 28335.7 28583.4 28729.7 28818.1 29554.3 28119.7 28261.7 28283.2 28339.9 28978.3 31051.4 31294.4 31446.2 31849.7 34528.8 28054.2 28899.7 29042.0 29054.7 29306.7 22916.5 22984.2 23202.0 23219.9 23240.8 15:23:24 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | [#2] jquery.html Cycles:180 Average:24272.63 Median:5149.39 stddev:71679.67 (1392.0%) stddev-sans-first:71858.18 15:23:24 INFO - PROCESS | 12511 | Values: 317.5 319.2 321.8 323.2 330.9 14532.6 14800.0 14963.6 15057.5 15648.5 9979.5 10283.4 12555.4 15341.2 15346.6 4386.1 4470.5 4579.7 5023.4 5049.6 4996.4 5075.7 5078.6 5080.7 5087.4 5037.9 5833.5 5950.1 6224.8 6240.0 5211.3 6058.9 6149.1 6528.9 6542.1 6200.4 6267.6 6280.1 6288.7 6289.9 19265.2 19451.9 19846.7 20543.5 20544.4 1773.6 1840.4 1845.9 1887.1 1898.1 13201.9 13218.9 13274.7 13510.2 13570.9 1838.1 1871.4 1875.1 1927.6 1939.7 56621.7 57708.0 58133.7 58201.7 58204.4 14432.6 14703.2 14719.3 14745.6 14838.6 21524.9 21659.4 21815.0 21851.7 22191.3 8715.7 8822.6 8887.6 8979.6 8984.4 7148.7 7214.5 7221.8 7492.0 7530.5 7072.0 7214.4 7219.2 7259.7 7280.3 1697.3 1745.4 2849.9 3043.6 3074.0 726.7 756.4 820.3 838.6 935.0 14867.9 14976.6 15336.2 15409.7 15597.9 689.4 802.4 844.4 853.1 874.7 8671.7 8808.2 8829.4 8886.2 8961.8 430376.0 437259.0 438356.0 440751.0 447458.0 64476.0 65189.3 65995.7 66436.0 66763.3 976.7 1050.5 1102.3 1113.0 1115.0 13043.3 13501.5 13519.5 13728.7 14014.6 27091.5 27273.3 27484.6 27587.0 28359.3 32188.8 32757.2 33006.8 34429.8 37724.8 6174.6 6431.5 6499.4 6511.8 6621.9 8000.3 9709.8 9753.0 9772.3 9778.8 2625.9 2661.8 5377.8 7518.2 8534.3 8648.6 8934.6 8965.6 9056.1 9126.5 7051.6 8756.9 9122.2 9163.4 9181.1 6594.8 6836.5 6893.9 6963.9 7124.4 7715.5 7831.5 8264.7 9135.3 9137.2 15:23:24 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | [#3] mootools.html Cycles:180 Average:5114.92 Median:6328.29 stddev:2706.48 (42.8%) stddev-sans-first:2699.58 15:23:24 INFO - PROCESS | 12511 | Values: 1388.7 1401.9 1526.6 1709.1 1730.6 7091.8 7263.8 7288.7 7460.7 7474.5 7225.3 7248.9 7315.1 7316.0 7331.0 2138.7 2151.5 2159.1 2159.4 2164.7 2178.8 2192.3 2252.3 2254.4 2257.2 1737.6 1771.2 2084.1 2174.9 2195.8 2136.4 2141.4 2144.8 2147.5 2148.4 2096.3 2141.1 2153.8 2157.8 2161.8 7366.5 7488.2 7525.3 7526.6 7531.4 4346.5 4443.3 4499.3 4504.3 4506.6 3009.8 3010.7 3081.7 3087.7 3114.3 861.6 877.2 882.7 885.1 907.4 9962.5 10013.9 10075.8 10076.8 10115.5 3897.6 3965.7 3966.9 3974.5 4110.5 8126.2 8127.6 8127.8 8158.6 8179.1 4252.7 4263.2 4281.0 4283.5 4291.5 3901.1 3905.3 3911.9 3923.0 3925.9 3222.4 3281.5 3301.0 3314.1 3330.7 986.8 1001.8 1003.0 1004.1 1017.1 778.6 821.6 869.3 945.2 1109.3 6705.8 6884.2 6898.4 6922.0 6930.1 554.2 565.2 585.1 585.7 706.6 5192.6 5202.8 5204.5 5206.8 5249.4 8378.7 9210.3 9224.3 9267.4 9281.2 9079.5 9092.7 9102.4 9150.0 9169.2 6717.1 6848.9 6868.3 6918.2 7103.4 6802.6 6810.8 6829.7 6831.1 6879.6 7697.5 7962.8 7967.1 7992.9 8104.1 8129.0 8236.5 8243.5 8246.8 8357.3 6507.7 6516.6 6564.7 6565.8 6581.0 6793.2 6820.1 6826.8 6833.7 6843.2 6644.8 6731.0 6765.4 6868.8 6886.0 5367.0 6216.3 6264.2 6354.6 6699.3 6134.6 6147.8 6187.9 6302.0 6472.4 6115.5 6142.2 6149.0 6158.5 6204.9 6296.1 6357.3 6371.7 6381.2 6382.7 15:23:24 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | [#4] prototype.html Cycles:180 Average:4878.46 Median:5491.64 stddev:1425.77 (26.0%) stddev-sans-first:1387.70 15:23:24 INFO - PROCESS | 12511 | Values: 298.0 308.0 310.6 316.2 320.7 5456.0 5541.2 5553.9 5613.3 5619.0 5527.3 5528.6 5565.9 5599.8 5600.3 4098.8 4245.2 4321.1 4327.4 4336.8 4215.8 4318.5 4341.6 4344.5 4346.3 4269.9 4273.4 4295.4 4303.8 4307.1 4300.7 4313.3 4314.1 4317.1 4323.5 3797.2 3802.2 3804.1 3807.9 3815.3 5215.5 5334.6 5348.3 5358.5 5359.7 4962.8 4964.7 4971.1 4972.3 4979.1 5839.5 5841.8 5842.0 5842.6 5846.4 4040.4 4131.6 4137.4 4140.0 4143.2 6138.2 6143.8 6144.7 6147.7 6153.6 4266.8 4274.1 4274.8 4279.0 4284.9 4337.0 4339.1 4342.4 4343.3 4348.2 4811.6 4936.7 4941.8 4944.9 4953.2 5805.7 5859.3 5866.9 5866.9 5868.2 1529.6 1542.4 1547.6 1553.3 1553.3 1062.0 1065.3 1070.9 1071.9 1088.4 5063.2 5084.0 5094.7 5096.3 5111.0 5948.2 6084.5 6148.2 6158.6 6162.9 5110.2 5112.2 5115.3 5121.4 5127.3 3235.5 3301.4 3305.2 3308.9 3310.2 5685.9 5793.3 5795.8 5797.9 5811.4 6280.1 6287.5 6292.9 6297.1 6305.1 5803.3 5804.1 5804.9 5805.9 5808.5 5939.4 6119.4 6124.4 6126.6 6156.6 5938.2 5981.3 5986.3 5992.7 6003.7 5782.6 5794.0 5798.5 5802.2 5814.8 4145.2 4181.9 4186.4 4194.9 4203.2 5993.9 6130.1 6131.9 6133.1 6142.9 5894.8 5900.6 5901.9 5904.1 5906.1 5875.6 5878.5 5880.5 5893.0 5896.0 5658.7 5727.2 5763.0 5771.6 5780.2 5907.2 5915.4 5917.9 5918.5 5933.8 5594.5 5742.2 5742.6 5747.5 5765.7 15:23:24 INFO - PROCESS | 12511 | 15:23:24 INFO - PROCESS | 12511 | [#5] yui.html Cycles:180 Average:11613.96 Median:496.35 stddev:13033.27 (2625.8%) stddev-sans-first:13044.29 15:23:24 INFO - PROCESS | 12511 | Values: 750.5 767.4 784.1 790.5 805.1 10616.4 10742.5 10750.2 10770.8 10780.3 10298.4 10315.5 10352.3 10386.8 10740.4 756.1 772.6 774.9 775.5 776.1 774.1 775.5 776.6 777.5 778.9 805.1 810.8 813.4 813.9 815.8 801.8 804.5 805.3 808.9 809.2 595.4 596.7 600.8 600.8 603.0 10488.2 10543.3 10558.7 10569.8 10620.6 9757.2 9888.7 9931.6 9960.6 9983.7 8325.7 8358.8 8390.7 8420.8 8481.0 3073.5 3117.1 3158.6 3163.3 3198.2 36245.3 36427.1 37146.3 37159.3 37445.3 9163.6 9235.2 9806.4 9867.7 9967.1 16962.6 17121.5 17123.4 17146.0 17164.7 6508.8 6631.0 6650.5 6657.4 6700.7 3611.4 3642.1 3642.3 3674.9 3763.3 2691.1 2711.4 2715.4 2716.7 2717.2 489.7 494.9 505.6 505.8 506.3 546.4 565.4 575.6 592.3 615.5 7264.7 7480.6 7500.4 7700.6 7775.0 497.8 576.6 578.5 591.6 625.2 3419.9 3438.0 3492.9 3515.8 3545.8 47961.0 48204.8 48423.3 48612.0 48612.8 41920.2 42172.6 42201.0 42443.4 42487.4 34294.5 38984.0 39941.0 43650.6 43804.6 7531.5 7897.5 7912.7 8160.1 8302.7 29412.4 29942.8 30785.8 30843.0 31142.5 32743.5 33619.7 33776.5 33945.8 33987.5 9287.4 9320.4 9347.9 9511.4 9690.1 10427.7 10657.5 10680.2 10949.7 11067.9 10349.0 10447.9 10479.6 10507.9 10557.5 10093.8 10119.8 10126.1 10141.8 10183.3 9977.8 10290.7 10457.0 10474.4 10487.6 8081.0 8118.3 8360.7 8450.6 8623.9 8745.7 8841.6 9003.9 9015.0 9039.5 15:23:24 INFO - PROCESS | 12511 | -------- Summary: end -------- 15:23:24 INFO - PROCESS | 12511 | 15:23:25 INFO - TEST-INFO | 12511: exit 0 15:23:25 INFO - TEST-OK | dromaeo_css | took 1113918ms 15:23:25 INFO - TEST-START | kraken 15:23:25 INFO - operating with platform_type : linux_ 15:23:25 INFO - Initialising browser for kraken test... 15:23:25 INFO - TEST-INFO | started process 12746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqL_2om/profile http://localhost:44376/getInfo.html) 15:23:29 INFO - PROCESS | 12746 | 15:23:29 INFO - PROCESS | 12746 | (process:12817): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:23:29 INFO - PROCESS | 12746 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:23:29 INFO - PROCESS | 12746 | __metrics Screen width/height:1600/1200 15:23:29 INFO - PROCESS | 12746 | colorDepth:24 15:23:29 INFO - PROCESS | 12746 | Browser inner width/height: 1024/697 15:23:29 INFO - PROCESS | 12746 | __metrics 15:23:29 INFO - PROCESS | 12746 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:23:30 INFO - TEST-INFO | 12746: exit 0 15:23:30 INFO - Browser initialized. 15:23:30 INFO - Running cycle 1/1 for kraken test... 15:23:30 INFO - TEST-INFO | started process 12866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqL_2om/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:32 INFO - PROCESS | 12866 | 15:23:32 INFO - PROCESS | 12866 | (process:12922): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:23:42 INFO - PROCESS | 12866 | RSS: Main: 150384640 15:23:42 INFO - PROCESS | 12866 | 15:23:45 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44376/tests/kraken/driver.html?testName=audio-beat-detection) 15:23:45 INFO - PROCESS | 12866 | RSS: Main: 152145920 15:23:45 INFO - PROCESS | 12866 | 15:23:48 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44376/tests/kraken/driver.html?testName=audio-dft) 15:23:49 INFO - PROCESS | 12866 | RSS: Main: 152035328 15:23:49 INFO - PROCESS | 12866 | 15:23:52 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44376/tests/kraken/driver.html?testName=audio-fft) 15:23:52 INFO - PROCESS | 12866 | RSS: Main: 146505728 15:23:52 INFO - PROCESS | 12866 | 15:23:54 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44376/tests/kraken/driver.html?testName=audio-oscillator) 15:23:55 INFO - PROCESS | 12866 | RSS: Main: 147202048 15:23:55 INFO - PROCESS | 12866 | 15:23:57 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:23:58 INFO - PROCESS | 12866 | RSS: Main: 147124224 15:23:58 INFO - PROCESS | 12866 | 15:24:01 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44376/tests/kraken/driver.html?testName=imaging-darkroom) 15:24:02 INFO - PROCESS | 12866 | RSS: Main: 146194432 15:24:02 INFO - PROCESS | 12866 | 15:24:05 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44376/tests/kraken/driver.html?testName=imaging-desaturate) 15:24:06 INFO - PROCESS | 12866 | RSS: Main: 148639744 15:24:06 INFO - PROCESS | 12866 | 15:24:08 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44376/tests/kraken/driver.html?testName=json-parse-financial) 15:24:09 INFO - PROCESS | 12866 | RSS: Main: 147755008 15:24:09 INFO - PROCESS | 12866 | 15:24:11 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:24:11 INFO - PROCESS | 12866 | RSS: Main: 149032960 15:24:11 INFO - PROCESS | 12866 | 15:24:13 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44376/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:24:14 INFO - PROCESS | 12866 | RSS: Main: 149094400 15:24:14 INFO - PROCESS | 12866 | 15:24:16 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:24:17 INFO - PROCESS | 12866 | RSS: Main: 148750336 15:24:17 INFO - PROCESS | 12866 | 15:24:19 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:24:20 INFO - PROCESS | 12866 | RSS: Main: 147677184 15:24:20 INFO - PROCESS | 12866 | 15:24:22 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:24:23 INFO - PROCESS | 12866 | RSS: Main: 149405696 15:24:23 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | Cycle 1(1): loaded http://localhost:44376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44376/tests/kraken/driver.html?testName=ai-astar) 15:24:25 INFO - PROCESS | 12866 | RSS: Main: 149581824 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | __start_tp_report 15:24:25 INFO - PROCESS | 12866 | _x_x_mozilla_page_load 15:24:25 INFO - PROCESS | 12866 | _x_x_mozilla_page_load_details 15:24:25 INFO - PROCESS | 12866 | |i|pagename|runs| 15:24:25 INFO - PROCESS | 12866 | |0;ai-astar;112;108;114;113;116;126;113;113;113;112 15:24:25 INFO - PROCESS | 12866 | |1;audio-beat-detection;156;129;163;168;130;163;154;130;171;133 15:24:25 INFO - PROCESS | 12866 | |2;audio-dft;162;162;164;163;161;168;171;162;165;163 15:24:25 INFO - PROCESS | 12866 | |3;audio-fft;73;76;72;73;130;72;76;84;72;93 15:24:25 INFO - PROCESS | 12866 | |4;audio-oscillator;98;97;138;96;96;97;138;95;98;135 15:24:25 INFO - PROCESS | 12866 | |5;imaging-gaussian-blur;110;110;109;110;111;109;110;110;110;113 15:24:25 INFO - PROCESS | 12866 | |6;imaging-darkroom;147;149;148;148;148;148;147;148;148;148 15:24:25 INFO - PROCESS | 12866 | |7;imaging-desaturate;95;97;97;96;97;96;96;96;96;96 15:24:25 INFO - PROCESS | 12866 | |8;json-parse-financial;73;70;71;70;70;70;70;77;69;69 15:24:25 INFO - PROCESS | 12866 | |9;json-stringify-tinderbox;68;71;68;68;67;68;67;69;68;69 15:24:25 INFO - PROCESS | 12866 | |10;stanford-crypto-aes;84;83;92;85;85;84;84;85;85;84 15:24:25 INFO - PROCESS | 12866 | |11;stanford-crypto-ccm;132;129;138;128;123;147;135;126;123;122 15:24:25 INFO - PROCESS | 12866 | |12;stanford-crypto-pbkdf2;137;156;153;151;160;141;150;153;151;148 15:24:25 INFO - PROCESS | 12866 | |13;stanford-crypto-sha256-iterative;73;72;70;72;73;72;73;75;75;71 15:24:25 INFO - PROCESS | 12866 | __end_tp_report 15:24:25 INFO - PROCESS | 12866 | __start_cc_report 15:24:25 INFO - PROCESS | 12866 | _x_x_mozilla_cycle_collect,794 15:24:25 INFO - PROCESS | 12866 | __end_cc_report 15:24:25 INFO - PROCESS | 12866 | __startTimestamp1452381865614__endTimestamp 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | ------- Summary: start ------- 15:24:25 INFO - PROCESS | 12866 | Number of tests: 14 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:4.67 (4.1%) stddev-sans-first:4.89 15:24:25 INFO - PROCESS | 12866 | Values: 112.0 108.0 114.0 113.0 116.0 126.0 113.0 113.0 113.0 112.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:159.50 stddev:17.27 (10.8%) stddev-sans-first:18.17 15:24:25 INFO - PROCESS | 12866 | Values: 156.0 129.0 163.0 168.0 130.0 163.0 154.0 130.0 171.0 133.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.14 (1.9%) stddev-sans-first:3.24 15:24:25 INFO - PROCESS | 12866 | Values: 162.0 162.0 164.0 163.0 161.0 168.0 171.0 162.0 165.0 163.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.50 stddev:18.14 (24.4%) stddev-sans-first:18.94 15:24:25 INFO - PROCESS | 12866 | Values: 73.0 76.0 72.0 73.0 130.0 72.0 76.0 84.0 72.0 93.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:96.50 stddev:19.50 (20.2%) stddev-sans-first:20.29 15:24:25 INFO - PROCESS | 12866 | Values: 98.0 97.0 138.0 96.0 96.0 97.0 138.0 95.0 98.0 135.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 15:24:25 INFO - PROCESS | 12866 | Values: 110.0 110.0 109.0 110.0 111.0 109.0 110.0 110.0 110.0 113.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 15:24:25 INFO - PROCESS | 12866 | Values: 147.0 149.0 148.0 148.0 148.0 148.0 147.0 148.0 148.0 148.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 15:24:25 INFO - PROCESS | 12866 | Values: 95.0 97.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#8] json-parse-financial Cycles:10 Average:70.90 Median:70.00 stddev:2.42 (3.5%) stddev-sans-first:2.45 15:24:25 INFO - PROCESS | 12866 | Values: 73.0 70.0 71.0 70.0 70.0 70.0 70.0 77.0 69.0 69.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 15:24:25 INFO - PROCESS | 12866 | Values: 68.0 71.0 68.0 68.0 67.0 68.0 67.0 69.0 68.0 69.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.51 (3.0%) stddev-sans-first:2.64 15:24:25 INFO - PROCESS | 12866 | Values: 84.0 83.0 92.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:130.50 stddev:7.92 (6.1%) stddev-sans-first:8.37 15:24:25 INFO - PROCESS | 12866 | Values: 132.0 129.0 138.0 128.0 123.0 147.0 135.0 126.0 123.0 122.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:152.00 stddev:6.75 (4.4%) stddev-sans-first:5.27 15:24:25 INFO - PROCESS | 12866 | Values: 137.0 156.0 153.0 151.0 160.0 141.0 150.0 153.0 151.0 148.0 15:24:25 INFO - PROCESS | 12866 | 15:24:25 INFO - PROCESS | 12866 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:1.58 (2.2%) stddev-sans-first:1.67 15:24:25 INFO - PROCESS | 12866 | Values: 73.0 72.0 70.0 72.0 73.0 72.0 73.0 75.0 75.0 71.0 15:24:25 INFO - PROCESS | 12866 | -------- Summary: end -------- 15:24:25 INFO - PROCESS | 12866 | 15:24:26 INFO - TEST-INFO | 12866: exit 0 15:24:26 INFO - TEST-OK | kraken | took 61097ms 15:24:26 INFO - TEST-START | v8_7 15:24:26 INFO - operating with platform_type : linux_ 15:24:26 INFO - Initialising browser for v8_7 test... 15:24:26 INFO - TEST-INFO | started process 13151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV1fKaS/profile http://localhost:44376/getInfo.html) 15:24:30 INFO - PROCESS | 13151 | 15:24:30 INFO - PROCESS | 13151 | (process:13222): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:24:30 INFO - PROCESS | 13151 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:24:30 INFO - PROCESS | 13151 | __metrics Screen width/height:1600/1200 15:24:30 INFO - PROCESS | 13151 | colorDepth:24 15:24:30 INFO - PROCESS | 13151 | Browser inner width/height: 1024/697 15:24:30 INFO - PROCESS | 13151 | __metrics 15:24:31 INFO - PROCESS | 13151 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:24:32 INFO - TEST-INFO | 13151: exit 0 15:24:32 INFO - Browser initialized. 15:24:32 INFO - Running cycle 1/1 for v8_7 test... 15:24:32 INFO - TEST-INFO | started process 13271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV1fKaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:33 INFO - PROCESS | 13271 | 15:24:33 INFO - PROCESS | 13271 | (process:13329): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:24:44 INFO - PROCESS | 13271 | RSS: Main: 150401024 15:24:44 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | Cycle 1(1): loaded http://localhost:44376/tests/v8_7/run.html (next: http://localhost:44376/tests/v8_7/run.html) 15:25:06 INFO - PROCESS | 13271 | RSS: Main: 145854464 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | __start_tp_report 15:25:06 INFO - PROCESS | 13271 | _x_x_mozilla_page_load 15:25:06 INFO - PROCESS | 13271 | _x_x_mozilla_page_load_details 15:25:06 INFO - PROCESS | 13271 | |i|pagename|runs| 15:25:06 INFO - PROCESS | 13271 | |0;Richards;166.08536787908986 15:25:06 INFO - PROCESS | 13271 | |1;DeltaBlue;185.90816136828406 15:25:06 INFO - PROCESS | 13271 | |2;Encrypt;278.31895352073474 15:25:06 INFO - PROCESS | 13271 | |3;Decrypt;5256.544502617801 15:25:06 INFO - PROCESS | 13271 | |4;RayTrace;1075.268817204301 15:25:06 INFO - PROCESS | 13271 | |5;Earley;726.2164124909223 15:25:06 INFO - PROCESS | 13271 | |6;Boyer;12304.878048780487 15:25:06 INFO - PROCESS | 13271 | |7;RegExp;42458.333333333336 15:25:06 INFO - PROCESS | 13271 | |8;Splay;595.3791469194313 15:25:06 INFO - PROCESS | 13271 | |9;NavierStokes;4830.917874396136 15:25:06 INFO - PROCESS | 13271 | __end_tp_report 15:25:06 INFO - PROCESS | 13271 | __startTimestamp1452381906791__endTimestamp 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | ------- Summary: start ------- 15:25:06 INFO - PROCESS | 13271 | Number of tests: 10 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 166.1 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#1] DeltaBlue Cycles:1 Average:185.91 Median:185.91 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 185.9 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 278.3 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 5256.5 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 1075.3 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#5] Earley Cycles:1 Average:726.22 Median:726.22 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 726.2 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 12304.9 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#7] RegExp Cycles:1 Average:42458.33 Median:42458.33 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 42458.3 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#8] Splay Cycles:1 Average:595.38 Median:595.38 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 595.4 15:25:06 INFO - PROCESS | 13271 | 15:25:06 INFO - PROCESS | 13271 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:25:06 INFO - PROCESS | 13271 | Values: 4830.9 15:25:06 INFO - PROCESS | 13271 | -------- Summary: end -------- 15:25:06 INFO - PROCESS | 13271 | 15:25:07 INFO - TEST-INFO | 13271: exit 0 15:25:07 INFO - TEST-OK | v8_7 | took 41151ms 15:25:07 INFO - SUITE-END | took 1216s 15:25:07 INFO - Completed test suite (00:20:16) 15:25:07 INFO - Working with test: dromaeo_css 15:25:07 INFO - Generating results file: dromaeo_css 15:25:07 INFO - Working with test: kraken 15:25:07 INFO - Generating results file: kraken 15:25:07 INFO - javascript benchmark 15:25:07 INFO - Working with test: v8_7 15:25:07 INFO - Generating results file: v8_7 15:25:07 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:25:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 15:25:07 INFO - process_Request line: dromaeo_css 6223.18 graph.html#tests=[[72,132,43]] 15:25:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:25:08 INFO - process_Request line: kraken 1550.20 graph.html#tests=[[232,132,43]] 15:25:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:25:08 INFO - process_Request line: v8_7 20310.78 graph.html#tests=[[230,132,43]] 15:25:08 INFO - RETURN: dromaeo_css: 6223.18 15:25:08 INFO - RETURN: kraken: 1550.20 15:25:08 INFO - RETURN: v8_7: 20310.78 15:25:08 INFO - javascript benchmark 15:25:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2644.0349272515527, 2688.690800557934, 2731.0577850641534, 2740.356016336161, 2757.5312196926525, 4521.90956180877, 4610.216263235246, 4641.976790116053, 4653.837115700947, 4661.790219440125, 4566.862994110182, 4595.885102872421, 4607.05555361151, 4704.0, 4715.85852424427, 4231.640310573605, 4250.06498570314, 4265.424167737347, 4302.548232435596, 4328.848490302824, 4284.507281662618, 4319.049809042006, 4322.438083049199, 4384.693071484981, 4404.559544045585, 4145.129522800185, 4232.343986682038, 4243.130158317537, 4330.913381732379, 4334.371516130159, 4181.226473102486, 4278.379634952915, 4297.462817147856, 4308.2675945089095, 4319.308910574293, 4186.099988502487, 4191.245575796355, 4197.958020419787, 4199.895002624959, 4220.2192594370135, 4309.095090031097, 4465.933011004838, 4469.374287599739, 4487.528809475023, 4563.498015218323, 4991.5258050485145, 4996.675216110941, 4999.975000125012, 5011.2483127530795, 5029.321041659366, 5031.421386540558, 5034.395872495324, 5034.697918124888, 5042.193249080166, 5078.568321692661, 4495.1683938471815, 4599.862004139881, 4603.434832157082, 4713.905721885578, 4715.457722361973, 5040.941402305483, 5063.367079115111, 5083.517065878736, 5088.9745551272745, 5100.413452452941, 4894.216925291937, 4900.852974410774, 4907.214845624683, 4910.116179087727, 4942.728149951715, 4804.8318308859025, 4903.313536104948, 4980.103581355318, 5039.042581909425, 5068.569171620454, 4913.926291105637, 4949.307097006422, 4957.058158949788, 4963.45402005779, 5007.349044624249, 4751.4535828379485, 4887.169181239198, 4923.507649235119, 4937.654364194472, 4965.950340496621, 4060.918781624351, 4085.5914408558906, 4150.584941505826, 4163.188178305262, 4177.373393990925, 3617.330793803102, 3618.927621447609, 3632.7093832493338, 3655.1593133579427, 3671.724620653462, 4152.273352163359, 4235.407043013981, 4253.361995700608, 4254.574542545721, 4256.1487702459635, 4893.853184404474, 4975.751212439363, 4976.154053810861, 4978.32792572998, 5020.623453241022, 4282.357646353072, 4282.892927676833, 4301.44081269433, 4317.222899877989, 4347.0, 4304.4834619845815, 4366.388705581221, 4399.62603178727, 4407.427034485497, 4433.578810013044, 4776.689515181502, 4785.760711964318, 4788.880277992938, 4795.064962332382, 4800.927986080282, 5016.046951079284, 5017.598592112695, 5018.021485810232, 5025.3718285214345, 5079.136546786981, 4582.358469814162, 4682.204025315773, 4689.671722979495, 4773.570378665937, 4808.495108013748, 4868.951310486991, 4884.755762211947, 4888.902221955612, 4903.141950158637, 4929.112759703288, 4962.528559786814, 4990.525900039491, 4999.925001124913, 5003.149464590955, 5036.169032109661, 4643.535646435329, 4799.088173247072, 4811.350467686958, 4872.366592342973, 4894.412670479423, 4816.95183048179, 4824.131656301899, 4832.806687732592, 4849.515048495264, 4882.267659851051, 4582.587567118975, 4736.692115012514, 4740.976295118502, 4765.0946320199055, 4770.308305295782, 4809.422869255712, 4836.347093142522, 4922.212446008622, 4923.532264434873, 4946.455889852042, 4733.928991065206, 4771.785269662804, 4803.855884323476, 4804.375431194062, 4855.854324370274], "unit": "score", "name": "dojo.html", "value": 4557.715508716764}, {"lowerIsBetter": false, "replicates": [483.25096101043374, 517.8135871086411, 519.5557798082639, 525.7318767428611, 541.8184908055802, 31111.844440777793, 31350.216244593896, 31759.206019849487, 31941.52087718686, 31945.36109277813, 31861.203469913264, 32647.347053058926, 32676.83661581695, 32683.836580817122, 32719.1820204495, 7411.518251313661, 7592.240775922419, 7593.582352970584, 7596.696132154735, 7599.012128423297, 7326.377257933082, 7584.3174114329695, 7615.428842836782, 7623.313901748841, 7627.7330293439745, 7556.319931206191, 7649.579273139975, 7685.846283074336, 7690.115636701795, 7700.499467534592, 7508.061492313461, 7535.095788505359, 7616.581088040183, 7623.809404764897, 7630.160682324939, 7543.471956963015, 7646.808829779245, 7652.196519365498, 7661.463697541174, 7677.309042186174, 33436.33127337464, 33538.6646133538, 33741.493877591856, 33747.662523374696, 33897.32205355904, 2858.0, 3163.225009872573, 3208.4866421372467, 3266.3957167923772, 3302.94305822137, 26723.46553068947, 26839.19482415511, 27192.72807271922, 27264.45471090587, 27759.444811103866, 3241.594800649919, 3242.5136229565755, 3274.099622603779, 3296.538484612156, 3336.6830151135605, 211799.0, 212073.0, 212534.0, 213594.0, 213653.0, 44402.55597444049, 45756.77121614437, 51000.489995099575, 51618.483815161366, 51620.74189629028, 46607.766961164976, 46627.30059049117, 46678.533214668096, 46777.064458710636, 46899.29651055237, 12193.085518586142, 12229.14395992272, 12273.815892761615, 12285.754284914252, 12292.139550231577, 9618.711438656852, 9731.756706082262, 9747.463889486004, 9773.560189791477, 9838.901610983941, 16720.916395417946, 17007.744883826752, 17822.019788911733, 17935.73096403555, 17971.550711232325, 6831.69257383419, 6940.444764418834, 7011.964940175369, 7016.228214896358, 7054.6825392857445, 817.513579420244, 832.4589017138908, 854.6495936665937, 879.7976465412863, 944.4003058058182, 26193.476130477284, 27195.592066119025, 27732.0, 27855.860720696266, 27932.44135117327, 938.4369378372921, 977.941323520591, 978.9118979291898, 988.2242439684813, 1027.157730660851, 13354.0, 13847.446102156002, 13977.79033314501, 14290.857091429161, 14712.19082950448, 249723.0, 254551.0, 255890.0, 255998.0, 257132.0, 44713.0, 44953.55046449494, 45082.774586126856, 45086.32370514445, 45215.96528156241, 1232.2236990695803, 1232.4146030635377, 1265.2787910890704, 1267.8922291605131, 1342.6576223063057, 25520.74479255258, 25894.741052589234, 25978.0, 26036.0, 26122.738772612793, 37841.05397365088, 38187.2362552753, 38287.42568861525, 38326.23347532978, 38354.23291534098, 198430.0, 198711.08377955385, 198715.0, 245266.0, 245807.0, 24290.08518977734, 24807.379815504755, 26491.337716557242, 28071.859640701667, 28260.152195433348, 33186.50220246746, 33333.333333333685, 33541.496877547346, 33660.158496037795, 33942.490862637576, 28335.716642834133, 28583.42833143284, 28729.71270287354, 28818.135455936357, 29554.261143471584, 28119.71880281171, 28261.717382825907, 28283.15150545487, 28339.858300708365, 28978.27554311159, 31051.378972420876, 31294.374112517165, 31446.213844654067, 31849.6815031856, 34528.82735586306, 28054.158375248775, 28899.7110028897, 29042.0, 29054.7094529052, 29306.681199345654, 22916.541669166858, 22984.195553155558, 23201.955911983663, 23219.88390058039, 23240.76759232386], "unit": "score", "name": "ext.html", "value": 15805.00030239388}, {"lowerIsBetter": false, "replicates": [317.5300555178336, 319.162199227029, 321.847122616757, 323.20007980248886, 330.9106541233867, 14532.63668408289, 14800.0, 14963.551093467186, 15057.472988445406, 15648.452304169356, 9979.451130187837, 10283.382997020184, 12555.435005424755, 15341.156236406992, 15346.616334591641, 4386.0789234260765, 4470.530594287602, 4579.656525760582, 5023.447420783729, 5049.64652474327, 4996.400431948153, 5075.670081444713, 5078.619103567229, 5080.745962701869, 5087.440381558025, 5037.949620503785, 5833.504152147073, 5950.077737950624, 6224.8132556023165, 6239.9688001559925, 5211.348581427322, 6058.909116363236, 6149.13912052313, 6528.869422611521, 6542.116814230066, 6200.410960958701, 6267.62394256346, 6280.120783090371, 6288.685565721696, 6289.937100629027, 19265.229390824352, 19451.90274048635, 19846.70229946552, 20543.4864128398, 20544.38366848982, 1773.5832079461316, 1840.402588066142, 1845.9077046147638, 1887.0736942523258, 1898.1078892920304, 13201.933990330082, 13218.86781132186, 13274.734505309936, 13510.189388636712, 13570.93214533921, 1838.1452624529659, 1871.354382737967, 1875.1374367790831, 1927.5566619677413, 1939.7187407825927, 56621.716891415694, 57707.99999999958, 58133.70933145307, 58201.7089914552, 58204.417955820325, 14432.639184020483, 14703.214552703714, 14719.337629806685, 14745.631359216106, 14838.629034274014, 21524.892375538024, 21659.35021949344, 21815.0, 21851.672224916638, 22191.334259971904, 8715.738527844174, 8822.647094116292, 8887.555622218862, 8979.595918183566, 8984.416012959136, 7148.678309476086, 7214.458915581353, 7221.783346499614, 7491.962540187374, 7530.548167109881, 7071.964640176869, 7214.422846172293, 7219.169795473483, 7259.673314700851, 7280.271972802678, 1697.2786565709523, 1745.4065617689791, 2849.871755770995, 3043.6195475565555, 3074.0, 726.6520604278986, 756.3911051603512, 820.2692319206469, 838.576518857985, 934.9859752103724, 14867.91293010705, 14976.550703478913, 15336.15651139198, 15409.691806163813, 15597.922010390103, 689.3830022130165, 802.3581135091903, 844.4251471006651, 853.0914575976565, 874.6719980007497, 8671.653133874574, 8808.20726134651, 8829.381943264038, 8886.183202678718, 8961.820763584692, 430376.0, 437259.0, 438356.0, 440751.0, 447458.0, 64476.0, 65189.348106519275, 65995.67002164958, 66436.0, 66763.33236667668, 976.7118699983522, 1050.5062620568322, 1102.2614848051824, 1113.0316624536704, 1114.9665510034713, 13043.347832608142, 13501.527446539323, 13519.459221631025, 13728.725425491633, 14014.649633759238, 27091.458170836868, 27273.31816704598, 27484.58773118365, 27587.0, 28359.29101772472, 32188.839055804572, 32757.181070472474, 33006.834965825015, 34429.82785086059, 37724.81137594295, 6174.567780255339, 6431.48548116159, 6499.350064993463, 6511.837204069936, 6621.900671490028, 8000.319972802145, 9709.805803884024, 9753.0, 9772.26707996889, 9778.804423911624, 2625.9474810504066, 2661.8136730428682, 5377.763114483612, 7518.188763663472, 8534.274586659954, 8648.567571621268, 8934.553272336227, 8965.59654815548, 9056.13966673165, 9126.49804260772, 7051.647417628996, 8756.912430875609, 9122.179003889682, 9163.358564900393, 9181.071974885348, 6594.769183078569, 6836.487263455161, 6893.862122757417, 6963.93036069653, 7124.3944264738075, 7715.4599178057, 7831.490953088031, 8264.710735124241, 9135.26917846584, 9137.223336016514], "unit": "score", "name": "jquery.html", "value": 8007.936213172127}, {"lowerIsBetter": false, "replicates": [1388.7083712420392, 1401.9018668693193, 1526.6336079340954, 1709.102721071438, 1730.5846596816768, 7091.751788687397, 7263.818404539889, 7288.708451661933, 7460.701571937123, 7474.5141565798185, 7225.349718525332, 7248.891266631004, 7315.085614298213, 7316.0489136412325, 7331.0469638947, 2138.6791981202828, 2151.5481748832763, 2159.147136880939, 2159.427751645815, 2164.7077644518026, 2178.8039076483115, 2192.2984644913636, 2252.2680128958073, 2254.4476603232233, 2257.221258665758, 1737.6177241007022, 1771.2118107442193, 2084.1038353507984, 2174.8803815790125, 2195.769444208359, 2136.3590922723197, 2141.3575927221927, 2144.8176904963098, 2147.5168087180414, 2148.3877095027997, 2096.2872623307994, 2141.1328411993168, 2153.7953894380007, 2157.7950094740972, 2161.7730138335405, 7366.521176123535, 7488.213737557532, 7525.322720955086, 7526.586037767921, 7531.397488200985, 4346.521882592912, 4443.311286750559, 4499.280115181588, 4504.256797628387, 4506.571875671806, 3009.7893147479685, 3010.698930106994, 3081.6918308169, 3087.691230876917, 3114.252579380955, 861.5907443964129, 877.1623099939543, 882.6557642519423, 885.1148851148852, 907.4464576608264, 9962.501874906298, 10013.89986100137, 10075.848862267072, 10076.848847267296, 10115.544800483996, 3897.590752970954, 3965.7422267552515, 3966.861159859449, 3974.5429275633674, 4110.547839737626, 8126.187381261945, 8127.634256458474, 8127.79680507992, 8158.632861521246, 8179.059408168017, 4252.723572967809, 4263.189993901149, 4280.978595107004, 4283.507396649363, 4291.463567054118, 3901.08324543732, 3905.297046531595, 3911.941320880189, 3922.9607703922597, 3925.9214815703526, 3222.371637530706, 3281.4585593376823, 3300.950485742716, 3314.0886256279714, 3330.7168890644566, 986.7763972673832, 1001.7645853224486, 1003.0320740485466, 1004.0862814838462, 1017.1252722658508, 778.5640041576735, 821.6056292979404, 869.2741560796679, 945.2013048973606, 1109.328856042099, 6705.798826035227, 6884.208316043619, 6898.448124150056, 6922.0, 6930.099087118743, 554.2406902543461, 565.2115299157653, 585.1106318396099, 585.745200837637, 706.6219572528672, 5192.636515443958, 5202.76587553561, 5204.531592156724, 5206.8437946860895, 5249.42256351801, 8378.664853405795, 9210.309226808016, 9224.30817688676, 9267.397619154734, 9281.21109705669, 9079.50062746542, 9092.681756138503, 9102.408343457653, 9150.03924587922, 9169.220616247694, 6717.126773519509, 6848.863022739517, 6868.347506986828, 6918.169819621577, 7103.437243806355, 6802.591844489149, 6810.829729256809, 6829.6585170742255, 6831.11195544576, 6879.58722476653, 7697.499662521918, 7962.761117166494, 7967.123616402076, 7992.920070799218, 8104.108548059591, 8129.0, 8236.464629799044, 8243.546604936786, 8246.752597422086, 8357.289630381485, 6507.707153178213, 6516.57642253252, 6564.704588293443, 6565.80302590923, 6580.967095164685, 6793.184817821893, 6820.079289295882, 6826.795196143925, 6833.726650933907, 6843.247242803387, 6644.76743314001, 6730.966345168243, 6765.42493888025, 6868.828279293058, 6886.0, 5367.0, 6216.2540495140875, 6264.185655864891, 6354.618722876642, 6699.29657385987, 6134.601250918676, 6147.84630384244, 6187.907181392193, 6301.96849015752, 6472.417482426604, 6115.510759139169, 6142.201513803177, 6149.046897730859, 6158.476529495043, 6204.875902481835, 6296.0555916612875, 6357.332480089709, 6371.713272902638, 6381.1704478417505, 6382.712777924911], "unit": "score", "name": "mootools.html", "value": 4117.5640483622}, {"lowerIsBetter": false, "replicates": [297.9731824135828, 307.9876804927802, 310.5683100490319, 316.23855126942925, 320.7081555784234, 5456.0, 5541.168824676301, 5553.888922221553, 5613.270274864262, 5618.988582055239, 5527.281453411061, 5528.55771538277, 5565.916511252334, 5599.804006859761, 5600.2719646446, 4098.774567398792, 4245.150969806035, 4321.070969741505, 4327.4157988671595, 4336.76147811871, 4215.789210539476, 4318.4817821861425, 4341.6092551670345, 4344.500382456011, 4346.282863327548, 4269.893252668677, 4273.423087883142, 4295.355696645513, 4303.7848107594655, 4307.0955099429, 4300.720453170549, 4313.266744653416, 4314.072474418, 4317.050248945227, 4323.481182258118, 3797.2405518896053, 3802.2205447883116, 3804.106035081781, 3807.9238415231816, 3815.313243616148, 5215.530602245816, 5334.5732341412595, 5348.304720386363, 5358.517733404013, 5359.705216213107, 4962.751862406865, 4964.67729597575, 4971.105201063807, 4972.328735620681, 4979.07887040895, 5839.503642190419, 5841.795537156222, 5842.006858834008, 5842.620229685057, 5846.386129456431, 4040.393940908858, 4131.628153466202, 4137.40007698885, 4139.958600414017, 4143.233501802176, 6138.202033735631, 6143.754249830002, 6144.662043587601, 6147.72335244915, 6153.630782153085, 4266.8293268269545, 4274.059706864485, 4274.764887931194, 4279.037216626234, 4284.935725964113, 4337.0, 4339.1104823511105, 4342.435483387139, 4343.283358245854, 4348.173846969065, 4811.591014763714, 4936.679115857458, 4941.827036053793, 4944.9258261126115, 4953.2074868020945, 5805.651660900359, 5859.296884373903, 5866.8533286667325, 5866.882662346729, 5868.207791948118, 1529.587011506887, 1542.4138827245574, 1547.6440418703762, 1553.30101454346, 1553.324303927795, 1061.9787604248027, 1065.3288428290127, 1070.9036186743074, 1071.8660167479065, 1088.374184843718, 5063.240513922941, 5084.0, 5094.668846525038, 5096.286519887219, 5110.97444512775, 5948.196993405922, 6084.452399283997, 6148.200733904564, 6158.599691020069, 6162.938370616326, 5110.207917772676, 5112.233165025276, 5115.309433226466, 5121.359830021247, 5127.282180494733, 3235.530848027023, 3301.422251106095, 3305.190228394011, 3308.8511017004294, 3310.155910242873, 5685.886282274414, 5793.333766616809, 5795.82612521625, 5797.88404231913, 5811.360750317462, 6280.057991301342, 6287.528435367274, 6292.905606415908, 6297.055441683692, 6305.054241863757, 5803.303603567514, 5804.100364443433, 5804.883902322014, 5805.912911306334, 5808.535317174616, 5939.4357536034, 6119.388061193845, 6124.418180272867, 6126.6017708848785, 6156.5998210116195, 5938.168656388023, 5981.312149102909, 5986.2517185351835, 5992.670403127696, 6003.729832157651, 5782.566307527037, 5794.0439827428, 5798.478136967693, 5802.216700745345, 5814.76740930358, 4145.191687620885, 4181.853635122756, 4186.434831297857, 4194.937075943924, 4203.222403855297, 5993.850153746017, 6130.080487926668, 6131.877362452637, 6133.141360209485, 6142.938570614237, 5894.793682221101, 5900.64596124234, 5901.911471327848, 5904.084866845646, 5906.114082887601, 5875.618084824644, 5878.500327472213, 5880.470757631662, 5893.0, 5896.0, 5658.651718542687, 5727.1695604138, 5763.0, 5771.624844385102, 5780.21967034445, 5907.172995780508, 5915.37888521699, 5917.881642367042, 5918.526517878646, 5933.762649493972, 5594.496495315441, 5742.224799651994, 5742.569307301886, 5747.5401967841635, 5765.654060756368], "unit": "score", "name": "prototype.html", "value": 4421.349909650208}, {"lowerIsBetter": false, "replicates": [750.500916890268, 767.3592550220566, 784.1178673991759, 790.4980337485695, 805.0741647105824, 10616.363018218912, 10742.462876856156, 10750.193735469851, 10770.78458430832, 10780.299280546758, 10298.382097074162, 10315.53580088896, 10352.275340726133, 10386.792264154712, 10740.409277489734, 756.0624825216732, 772.563501621582, 774.8605251054807, 775.5346791924828, 776.119104816035, 774.1136398823344, 775.51917810957, 776.6116941529235, 777.4518964130275, 778.9415793815458, 805.0942689474341, 810.84999275134, 813.353384059674, 813.8535063688533, 815.824597711492, 801.8115742800408, 804.4931693033352, 805.2712295372697, 808.8827120067557, 809.1746418652971, 595.4462350014485, 596.6956852005464, 600.771706751436, 600.780715039012, 603.0, 10488.160947124288, 10543.314684545558, 10558.68323950275, 10569.841452378221, 10620.628278010232, 9757.219422446187, 9888.703338899844, 9931.60217918641, 9960.601575936953, 9983.650572229937, 8325.708600199025, 8358.832823343499, 8390.664373425056, 8420.8315833683, 8480.957595212047, 3073.523603841408, 3117.0960421477744, 3158.589383380169, 3163.3040731039137, 3198.1684761962056, 36245.275094498225, 36427.08932276688, 37146.25707485862, 37159.256814863824, 37445.25109497822, 9163.58763855628, 9235.215006724504, 9806.411615303105, 9867.654632087842, 9967.053129952643, 16962.575935601708, 17121.486355409357, 17123.400680976356, 17146.0, 17164.742528862076, 6508.8047358579315, 6631.0, 6650.53446258767, 6657.434118099919, 6700.698468568926, 3611.4041183205004, 3642.1076836175307, 3642.34437801193, 3674.9448758268645, 3763.2701656910626, 2691.138835572637, 2711.417045335262, 2715.3618899558587, 2716.714744951791, 2717.171262764876, 489.7184119131514, 494.8540180646718, 505.623310633573, 505.815377387251, 506.29119233073993, 546.4016901492859, 565.4402141879592, 575.602834044508, 592.2862950145064, 615.5321955313904, 7264.709411623581, 7480.551166930001, 7500.399968002546, 7700.614969251627, 7774.961125194451, 497.8382025841616, 576.6136688418769, 578.5082679722286, 591.5754901766809, 625.2247213455282, 3419.863205471803, 3437.9812700295493, 3492.89521314361, 3515.7538972271695, 3545.8227088645463, 47961.0, 48204.758976204896, 48423.273650895266, 48612.0, 48612.75693621509, 41920.161596767895, 42172.57827421748, 42201.0, 42443.36334954978, 42487.36268955968, 34294.48558271628, 38984.0, 39941.0, 43650.563494365284, 43804.56195438005, 7531.548107113591, 7897.526148431112, 7912.68349266046, 8160.102388737116, 8302.6678932842, 29412.411751764415, 29942.754293427643, 30785.8460707695, 30843.0, 31142.53286200754, 32743.508847366833, 33619.663803361655, 33776.49335259924, 33945.830270848484, 33987.49018764671, 9287.442753434816, 9320.440773553608, 9347.906520934703, 9511.381760185843, 9690.12788849007, 10427.68716938493, 10657.520411581343, 10680.198985075995, 10949.726256843323, 11067.944660276647, 10348.981948520268, 10447.895521044693, 10479.580816767244, 10507.94746026265, 10557.472126393803, 10093.848592271268, 10119.848202277119, 10126.13927816144, 10141.79716405653, 10183.338083024875, 9977.800443991226, 10290.742731431774, 10457.0, 10474.371537707762, 10487.632932847313, 8081.0, 8118.3099436548555, 8360.70737524208, 8450.577471126542, 8623.8706419405, 8745.693900713444, 8841.60212790413, 9003.919529656483, 9015.0, 9039.45763254207], "unit": "score", "name": "yui.html", "value": 5530.6427623386235}], "name": "dromaeo_css", "value": 6223.178806787578}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 114.0, 113.0, 116.0, 126.0, 113.0, 113.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 163.0, 168.0, 130.0, 163.0, 154.0, 130.0, 171.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 163.0, 161.0, 168.0, 171.0, 162.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 72.0, 73.0, 130.0, 72.0, 76.0, 84.0, 72.0, 93.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 138.0, 96.0, 96.0, 97.0, 138.0, 95.0, 98.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 113.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 71.0, 70.0, 70.0, 70.0, 70.0, 77.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.9}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 68.0, 67.0, 68.0, 67.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 92.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [132.0, 129.0, 138.0, 128.0, 123.0, 147.0, 135.0, 126.0, 123.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [137.0, 156.0, 153.0, 151.0, 160.0, 141.0, 150.0, 153.0, 151.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 70.0, 72.0, 73.0, 72.0, 73.0, 75.0, 75.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.6}], "name": "kraken", "value": 1550.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [185.90816136828406], "unit": "score", "name": "DeltaBlue", "value": 355.64872200000013}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [726.2164124909223], "unit": "score", "name": "Earley", "value": 917.719551}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [42458.333333333336], "unit": "score", "name": "RegExp", "value": 21.455976447497545}, {"lowerIsBetter": false, "replicates": [595.3791469194313], "unit": "score", "name": "Splay", "value": 136.87244577114427}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20310.778252547432}]} 15:25:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20310.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1550.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6223.18"}}} 15:25:08 INFO - Return code: 0 15:25:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:25:08 INFO - # TBPL SUCCESS # 15:25:08 INFO - Running post-action listener: _resource_record_post_action 15:25:08 INFO - Running post-run listener: _resource_record_post_run 15:25:09 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 552943616; Read time: 0; Write time: 441900 15:25:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231735296; Read time: 0; Write time: 242852 15:25:09 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 320925696; Read time: 0; Write time: 199024 15:25:09 INFO - Running post-run listener: _upload_blobber_files 15:25:09 INFO - Blob upload gear active. 15:25:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:25:09 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 15:25:09 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'] 15:25:09 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 15:25:09 INFO - (blobuploader) - INFO - Open directory for files ... 15:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:25:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:10 INFO - (blobuploader) - INFO - Done attempting. 15:25:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:25:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:25:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:11 INFO - (blobuploader) - INFO - Done attempting. 15:25:11 INFO - (blobuploader) - INFO - Iteration through files over. 15:25:11 INFO - Return code: 0 15:25:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:25:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:25:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36df0f58d08123acac741b0d33c15d39c090cfdcdd815c18bebd83c448b94caf2c223bf1e8c07994c8d50b0b28f8784ac819cb60d139e4cb7004a05383bd3059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80696a23a7576ef6467deca4c69bfa3c831ec244d468128bfc5d0aec8cd828404b302c50150d609ea6f3911c3e388cfd9e15f128e510e477233a5fafb70e234"} 15:25:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:25:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:25:11 INFO - Contents: 15:25:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36df0f58d08123acac741b0d33c15d39c090cfdcdd815c18bebd83c448b94caf2c223bf1e8c07994c8d50b0b28f8784ac819cb60d139e4cb7004a05383bd3059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80696a23a7576ef6467deca4c69bfa3c831ec244d468128bfc5d0aec8cd828404b302c50150d609ea6f3911c3e388cfd9e15f128e510e477233a5fafb70e234"} 15:25:11 INFO - Copying logs to upload dir... 15:25:11 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.389788 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-09 15:25:11.278658) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 15:25:11.282027) ========= 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=0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461 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/36df0f58d08123acac741b0d33c15d39c090cfdcdd815c18bebd83c448b94caf2c223bf1e8c07994c8d50b0b28f8784ac819cb60d139e4cb7004a05383bd3059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80696a23a7576ef6467deca4c69bfa3c831ec244d468128bfc5d0aec8cd828404b302c50150d609ea6f3911c3e388cfd9e15f128e510e477233a5fafb70e234"} build_url:https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/cI2APV0KSuixVrIgp9ROjQ/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/36df0f58d08123acac741b0d33c15d39c090cfdcdd815c18bebd83c448b94caf2c223bf1e8c07994c8d50b0b28f8784ac819cb60d139e4cb7004a05383bd3059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e80696a23a7576ef6467deca4c69bfa3c831ec244d468128bfc5d0aec8cd828404b302c50150d609ea6f3911c3e388cfd9e15f128e510e477233a5fafb70e234"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 15:25:11.307039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:25:11.307352) ========= 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=0274524eba3bdaad075c2247000001d4-1452380398.316495-1765094461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:25:11.392854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 15:25:11.393187) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 15:25:11.393478) ========= ========= Total master_lag: 0.28 =========