builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1452121709.11 results: success (0) buildid: 20160106143107 builduid: a2802f2788344d45b02a331e8fc8992d revision: e999b2a3a76618a30d2f81b09af7ed78bdc83610 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.112189) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.112643) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.113241) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006326 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.143523) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.143827) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.201694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.202192) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.272331) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.272619) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.272970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.273278) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 15:08:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-06 15:08:29 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.451530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.451814) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020211 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:29.500603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 15:08:29.500909) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e999b2a3a76618a30d2f81b09af7ed78bdc83610 --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 e999b2a3a76618a30d2f81b09af7ed78bdc83610 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 15:08:29,624 truncating revision to first 12 chars 2016-01-06 15:08:29,624 Setting DEBUG logging. 2016-01-06 15:08:29,624 attempt 1/10 2016-01-06 15:08:29,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e999b2a3a766?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 15:08:30,852 unpacking tar archive at: fx-team-e999b2a3a766/testing/mozharness/ program finished with exit code 0 elapsedTime=1.529776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 15:08:31.044367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:31.044669) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:31.053005) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:31.053342) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 15:08:31.053769) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 29 secs) (at 2016-01-06 15:08:31.054074) ========= /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=c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:08:31 INFO - MultiFileLogger online at 20160106 15:08:31 in /builds/slave/test 15:08:31 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:08:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:08:31 INFO - {'append_to_log': False, 15:08:31 INFO - 'base_work_dir': '/builds/slave/test', 15:08:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:08:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:08:31 INFO - 'branch': 'Fx-Team-Non-PGO', 15:08:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:08:31 INFO - 'config_files': ('talos/linux_config.py',), 15:08:31 INFO - 'default_actions': ('clobber', 15:08:31 INFO - 'read-buildbot-config', 15:08:31 INFO - 'download-and-extract', 15:08:31 INFO - 'populate-webroot', 15:08:31 INFO - 'create-virtualenv', 15:08:31 INFO - 'install', 15:08:31 INFO - 'run-tests'), 15:08:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:08:31 INFO - 'download_minidump_stackwalk': True, 15:08:31 INFO - 'download_symbols': 'ondemand', 15:08:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:08:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:08:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:08:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:08:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:08:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:08:31 INFO - 'installer_path': 'installer.exe', 15:08:31 INFO - 'log_level': 'info', 15:08:31 INFO - 'log_name': 'talos', 15:08:31 INFO - 'log_to_console': True, 15:08:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:08:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:08:31 INFO - 'opt_config_files': (), 15:08:31 INFO - 'pip_index': False, 15:08:31 INFO - 'sps_profile': False, 15:08:31 INFO - 'sps_profile_interval': 0, 15:08:31 INFO - 'suite': 'dromaeojs-e10s', 15:08:31 INFO - 'system_bits': '32', 15:08:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:08:31 INFO - 'title': 'talos-linux64-ix-004', 15:08:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:08:31 INFO - 'use_talos_json': True, 15:08:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:08:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:08:31 INFO - 'work_dir': 'build'} 15:08:31 INFO - ##### 15:08:31 INFO - ##### Running clobber step. 15:08:31 INFO - ##### 15:08:31 INFO - Running pre-action listener: _resource_record_pre_action 15:08:31 INFO - Running main action method: clobber 15:08:31 INFO - rmtree: /builds/slave/test/build 15:08:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:08:31 INFO - Running post-action listener: _resource_record_post_action 15:08:31 INFO - ##### 15:08:31 INFO - ##### Running read-buildbot-config step. 15:08:31 INFO - ##### 15:08:31 INFO - Running pre-action listener: _resource_record_pre_action 15:08:31 INFO - Running main action method: read_buildbot_config 15:08:31 INFO - Using buildbot properties: 15:08:31 INFO - { 15:08:31 INFO - "project": "", 15:08:31 INFO - "product": "firefox", 15:08:31 INFO - "script_repo_revision": "production", 15:08:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:08:31 INFO - "repository": "", 15:08:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:08:31 INFO - "buildid": "20160106143107", 15:08:31 INFO - "pgo_build": "False", 15:08:31 INFO - "basedir": "/builds/slave/test", 15:08:31 INFO - "buildnumber": 660, 15:08:31 INFO - "slavename": "talos-linux64-ix-004", 15:08:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:08:31 INFO - "platform": "ubuntu64_hw", 15:08:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:08:31 INFO - "branch": "fx-team", 15:08:31 INFO - "repo_path": "integration/fx-team", 15:08:31 INFO - "revision": "e999b2a3a76618a30d2f81b09af7ed78bdc83610", 15:08:31 INFO - "stage_platform": "linux64", 15:08:31 INFO - "builduid": "a2802f2788344d45b02a331e8fc8992d", 15:08:31 INFO - "slavebuilddir": "test" 15:08:31 INFO - } 15:08:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:08:31 INFO - Running post-action listener: _resource_record_post_action 15:08:31 INFO - ##### 15:08:31 INFO - ##### Running download-and-extract step. 15:08:31 INFO - ##### 15:08:31 INFO - Running pre-action listener: _resource_record_pre_action 15:08:31 INFO - Running main action method: download_and_extract 15:08:31 INFO - mkdir: /builds/slave/test/build/tests 15:08: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:08:31 INFO - https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/test_packages.json 15:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/test_packages.json 15:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:08:40 INFO - Downloaded 1302 bytes. 15:08:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:08:40 INFO - Using the following test package requirements: 15:08:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:08:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:08:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:08:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:08:40 INFO - u'jsshell-linux-x86_64.zip'], 15:08:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:08:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:08:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:08:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:08:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:08:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:08:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:08:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:08:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:08:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:08:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:08:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:08:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:40 INFO - https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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:08:44 INFO - Downloaded 22834895 bytes. 15:08:44 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:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:08:44 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:08:46 INFO - Return code: 0 15:08:46 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:08:46 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:08:46 INFO - https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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:08:50 INFO - Downloaded 22834895 bytes. 15:08:50 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:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:08:50 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:08:52 INFO - Return code: 0 15:08:52 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:08:52 INFO - https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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:08:53 INFO - Downloaded 11132285 bytes. 15:08:53 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:08:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:08:53 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:08:53 INFO - Return code: 0 15:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:53 INFO - https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:08:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:08:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:08:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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:09:25 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 15:09:25 INFO - retry: attempt #1 caught exception: The read operation timed out 15:09:25 INFO - retry: Failed, sleeping 30 seconds before retrying 15:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B_qCfYVsSi64-l7DxlXc8A/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 #2 15:09:57 INFO - Downloaded 53465983 bytes. 15:09:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:09:57 INFO - mkdir: /builds/slave/test/properties 15:09:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:09:57 INFO - Writing to file /builds/slave/test/properties/build_url 15:09:57 INFO - Contents: 15:09:57 INFO - build_url:https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:09:57 INFO - Running post-action listener: _resource_record_post_action 15:09:57 INFO - Running post-action listener: set_extra_try_arguments 15:09:57 INFO - ##### 15:09:57 INFO - ##### Running populate-webroot step. 15:09:57 INFO - ##### 15:09:57 INFO - Running pre-action listener: _resource_record_pre_action 15:09:57 INFO - Running main action method: populate_webroot 15:09:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:09:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:09:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:09:57 INFO - '--tppagecycles', 15:09:57 INFO - '7'], 15:09:57 INFO - 'tests': ['tsvgm']}}, 15:09:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:09:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:09:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:09:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:09:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:09:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:57 INFO - 'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:09:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:57 INFO - 'tests': ['damp', 'tps']}, 15:09:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:57 INFO - 'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['damp', 'tps']}, 15:09:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:09:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:09:57 INFO - 'other': {'tests': ['a11yr', 15:09:57 INFO - 'ts_paint', 15:09:57 INFO - 'tpaint', 15:09:57 INFO - 'sessionrestore', 15:09:57 INFO - 'sessionrestore_no_auto_restore']}, 15:09:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['a11yr', 15:09:57 INFO - 'ts_paint', 15:09:57 INFO - 'tpaint', 15:09:57 INFO - 'sessionrestore', 15:09:57 INFO - 'sessionrestore_no_auto_restore']}, 15:09:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['a11yr', 15:09:57 INFO - 'ts_paint', 15:09:57 INFO - 'tpaint', 15:09:57 INFO - 'sessionrestore', 15:09:57 INFO - 'sessionrestore_no_auto_restore']}, 15:09:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['a11yr', 15:09:57 INFO - 'ts_paint', 15:09:57 INFO - 'tpaint', 15:09:57 INFO - 'sessionrestore', 15:09:57 INFO - 'sessionrestore_no_auto_restore']}, 15:09:57 INFO - 'other_l64': {'tests': ['a11yr', 15:09:57 INFO - 'ts_paint', 15:09:57 INFO - 'tpaint', 15:09:57 INFO - 'sessionrestore', 15:09:57 INFO - 'sessionrestore_no_auto_restore']}, 15:09:57 INFO - 'other_nol64': {'tests': ['a11yr', 15:09:57 INFO - 'ts_paint', 15:09:57 INFO - 'tpaint', 15:09:57 INFO - 'sessionrestore', 15:09:57 INFO - 'sessionrestore_no_auto_restore']}, 15:09:57 INFO - 'svgr': {'tests': ['tsvgx', 15:09:57 INFO - 'tsvgr_opacity', 15:09:57 INFO - 'tart', 15:09:57 INFO - 'tscrollx', 15:09:57 INFO - 'cart']}, 15:09:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['tsvgx', 15:09:57 INFO - 'tsvgr_opacity', 15:09:57 INFO - 'tart', 15:09:57 INFO - 'tscrollx', 15:09:57 INFO - 'cart']}, 15:09:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:57 INFO - 'tests': ['tp5o']}, 15:09:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:57 INFO - 'talos_options': ['--e10s'], 15:09:57 INFO - 'tests': ['tp5o']}, 15:09:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:57 INFO - 'talos_options': ['--xperf_path', 15:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:09:57 INFO - 'tests': ['tp5n']}, 15:09:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:57 INFO - 'talos_options': ['--e10s', 15:09:57 INFO - '--xperf_path', 15:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:09:57 INFO - 'tests': ['tp5n']}}, 15:09:57 INFO - 'talos.zip': {'path': '', 15:09:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:09:57 INFO - Running post-action listener: _resource_record_post_action 15:09:57 INFO - ##### 15:09:57 INFO - ##### Running create-virtualenv step. 15:09:57 INFO - ##### 15:09:57 INFO - Running pre-action listener: _resource_record_pre_action 15:09:57 INFO - Running main action method: create_virtualenv 15:09:57 INFO - Creating virtualenv /builds/slave/test/build/venv 15:09:57 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:09:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:09:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:09:57 INFO - Using real prefix '/usr' 15:09:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:09:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:09:59 INFO - Installing pip.................done. 15:09:59 INFO - Return code: 0 15:09:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:09:59 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:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:59 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:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:59 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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:09:59 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:09:59 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:09:59 INFO - Using env: {'DISPLAY': ':0', 15:09:59 INFO - 'HOME': '/home/cltbld', 15:09:59 INFO - 'LANG': 'en_US.UTF-8', 15:09:59 INFO - 'LANGUAGE': 'en_US:en', 15:09:59 INFO - 'LOGNAME': 'cltbld', 15:09:59 INFO - 'MAIL': '/var/mail/cltbld', 15:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:59 INFO - 'MOZ_NO_REMOTE': '1', 15:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:59 INFO - 'NO_EM_RESTART': '1', 15:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:59 INFO - 'PWD': '/builds/slave/test', 15:09:59 INFO - 'SHELL': '/bin/bash', 15:09:59 INFO - 'SHLVL': '1', 15:09:59 INFO - 'TERM': 'linux', 15:09:59 INFO - 'TMOUT': '86400', 15:09:59 INFO - 'USER': 'cltbld', 15:09:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:59 INFO - '_': '/tools/buildbot/bin/python'} 15:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:59 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:09:59 INFO - Cleaning up... 15:09:59 INFO - Return code: 0 15:09:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:09:59 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:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:59 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:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:59 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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:09:59 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:09:59 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:09:59 INFO - Using env: {'DISPLAY': ':0', 15:09:59 INFO - 'HOME': '/home/cltbld', 15:09:59 INFO - 'LANG': 'en_US.UTF-8', 15:09:59 INFO - 'LANGUAGE': 'en_US:en', 15:09:59 INFO - 'LOGNAME': 'cltbld', 15:09:59 INFO - 'MAIL': '/var/mail/cltbld', 15:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:59 INFO - 'MOZ_NO_REMOTE': '1', 15:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:59 INFO - 'NO_EM_RESTART': '1', 15:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:59 INFO - 'PWD': '/builds/slave/test', 15:09:59 INFO - 'SHELL': '/bin/bash', 15:09:59 INFO - 'SHLVL': '1', 15:09:59 INFO - 'TERM': 'linux', 15:09:59 INFO - 'TMOUT': '86400', 15:09:59 INFO - 'USER': 'cltbld', 15:09:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:59 INFO - '_': '/tools/buildbot/bin/python'} 15:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:00 INFO - Downloading/unpacking psutil>=0.7.1 15:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:10:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:01 INFO - Installing collected packages: psutil 15:10:01 INFO - Running setup.py install for psutil 15:10:02 INFO - building 'psutil._psutil_linux' extension 15:10:02 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:10:02 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:10:02 INFO - building 'psutil._psutil_posix' extension 15:10:02 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:10:02 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:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:02 INFO - Successfully installed psutil 15:10:02 INFO - Cleaning up... 15:10:02 INFO - Return code: 0 15:10:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:02 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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:10:02 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:10:02 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:10:02 INFO - Using env: {'DISPLAY': ':0', 15:10:02 INFO - 'HOME': '/home/cltbld', 15:10:02 INFO - 'LANG': 'en_US.UTF-8', 15:10:02 INFO - 'LANGUAGE': 'en_US:en', 15:10:02 INFO - 'LOGNAME': 'cltbld', 15:10:02 INFO - 'MAIL': '/var/mail/cltbld', 15:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:02 INFO - 'MOZ_NO_REMOTE': '1', 15:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:02 INFO - 'NO_EM_RESTART': '1', 15:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:02 INFO - 'PWD': '/builds/slave/test', 15:10:02 INFO - 'SHELL': '/bin/bash', 15:10:02 INFO - 'SHLVL': '1', 15:10:02 INFO - 'TERM': 'linux', 15:10:02 INFO - 'TMOUT': '86400', 15:10:02 INFO - 'USER': 'cltbld', 15:10:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:02 INFO - '_': '/tools/buildbot/bin/python'} 15:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:10:02 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:10:02 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:10:02 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:10:02 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:10:02 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:10:02 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:10:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:10:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:04 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:10:04 INFO - Installing collected packages: mozsystemmonitor 15:10:04 INFO - Running setup.py install for mozsystemmonitor 15:10:04 INFO - Successfully installed mozsystemmonitor 15:10:04 INFO - Cleaning up... 15:10:04 INFO - Return code: 0 15:10:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10:04 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:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:04 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:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:04 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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:10:04 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:10:04 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:10:04 INFO - Using env: {'DISPLAY': ':0', 15:10:04 INFO - 'HOME': '/home/cltbld', 15:10:04 INFO - 'LANG': 'en_US.UTF-8', 15:10:04 INFO - 'LANGUAGE': 'en_US:en', 15:10:04 INFO - 'LOGNAME': 'cltbld', 15:10:04 INFO - 'MAIL': '/var/mail/cltbld', 15:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:04 INFO - 'MOZ_NO_REMOTE': '1', 15:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:04 INFO - 'NO_EM_RESTART': '1', 15:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:04 INFO - 'PWD': '/builds/slave/test', 15:10:04 INFO - 'SHELL': '/bin/bash', 15:10:04 INFO - 'SHLVL': '1', 15:10:04 INFO - 'TERM': 'linux', 15:10:04 INFO - 'TMOUT': '86400', 15:10:04 INFO - 'USER': 'cltbld', 15:10:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:04 INFO - '_': '/tools/buildbot/bin/python'} 15:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:06 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:07 INFO - Downloading docopt-0.6.1.tar.gz 15:10:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:07 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:07 INFO - Running setup.py install for blobuploader 15:10:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:07 INFO - Running setup.py install for requests 15:10:07 INFO - Running setup.py install for docopt 15:10:07 INFO - Successfully installed blobuploader requests docopt 15:10:07 INFO - Cleaning up... 15:10:07 INFO - Return code: 0 15:10:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:07 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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:10:07 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:10:07 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:10:07 INFO - Using env: {'DISPLAY': ':0', 15:10:07 INFO - 'HOME': '/home/cltbld', 15:10:07 INFO - 'LANG': 'en_US.UTF-8', 15:10:07 INFO - 'LANGUAGE': 'en_US:en', 15:10:07 INFO - 'LOGNAME': 'cltbld', 15:10:07 INFO - 'MAIL': '/var/mail/cltbld', 15:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:07 INFO - 'MOZ_NO_REMOTE': '1', 15:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:07 INFO - 'NO_EM_RESTART': '1', 15:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:07 INFO - 'PWD': '/builds/slave/test', 15:10:07 INFO - 'SHELL': '/bin/bash', 15:10:07 INFO - 'SHLVL': '1', 15:10:07 INFO - 'TERM': 'linux', 15:10:07 INFO - 'TMOUT': '86400', 15:10:07 INFO - 'USER': 'cltbld', 15:10:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:07 INFO - '_': '/tools/buildbot/bin/python'} 15:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:08 INFO - Running setup.py (path:/tmp/pip-Ggn4R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:08 INFO - Running setup.py (path:/tmp/pip-qTkJQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:08 INFO - Running setup.py (path:/tmp/pip-eNsfZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:08 INFO - Running setup.py (path:/tmp/pip-jCv8pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:08 INFO - Running setup.py (path:/tmp/pip-csRcuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:08 INFO - Running setup.py (path:/tmp/pip-1GyzGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:08 INFO - Running setup.py (path:/tmp/pip-HvwwXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:08 INFO - Running setup.py (path:/tmp/pip-WMnoD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:08 INFO - Running setup.py (path:/tmp/pip-azhINv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:08 INFO - Running setup.py (path:/tmp/pip-3BQ1Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:08 INFO - Running setup.py (path:/tmp/pip-J6j1I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:08 INFO - Running setup.py (path:/tmp/pip-glAYD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:08 INFO - Running setup.py (path:/tmp/pip-kpo8nW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:09 INFO - Running setup.py (path:/tmp/pip-fkhTLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:09 INFO - Running setup.py (path:/tmp/pip-vpQA3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:09 INFO - Running setup.py (path:/tmp/pip-gi_1FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:09 INFO - Running setup.py (path:/tmp/pip-ZgE0Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:09 INFO - Running setup.py install for manifestparser 15:10:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:09 INFO - Running setup.py install for mozcrash 15:10:09 INFO - Running setup.py install for mozdebug 15:10:09 INFO - Running setup.py install for mozdevice 15:10:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:10:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:09 INFO - Running setup.py install for mozfile 15:10:09 INFO - Running setup.py install for mozhttpd 15:10:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:09 INFO - Running setup.py install for mozinfo 15:10:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Running setup.py install for mozInstall 15:10:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Running setup.py install for mozleak 15:10:10 INFO - Running setup.py install for mozlog 15:10:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Running setup.py install for moznetwork 15:10:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Running setup.py install for mozprocess 15:10:10 INFO - Running setup.py install for mozprofile 15:10:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Running setup.py install for mozrunner 15:10:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:10:10 INFO - Running setup.py install for mozscreenshot 15:10:10 INFO - Running setup.py install for moztest 15:10:10 INFO - Running setup.py install for mozversion 15:10:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:10:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:10:11 INFO - Cleaning up... 15:10:11 INFO - Return code: 0 15:10:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:10:11 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:10:11 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:10:11 INFO - Using env: {'DISPLAY': ':0', 15:10:11 INFO - 'HOME': '/home/cltbld', 15:10:11 INFO - 'LANG': 'en_US.UTF-8', 15:10:11 INFO - 'LANGUAGE': 'en_US:en', 15:10:11 INFO - 'LOGNAME': 'cltbld', 15:10:11 INFO - 'MAIL': '/var/mail/cltbld', 15:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:11 INFO - 'MOZ_NO_REMOTE': '1', 15:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:11 INFO - 'NO_EM_RESTART': '1', 15:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:11 INFO - 'PWD': '/builds/slave/test', 15:10:11 INFO - 'SHELL': '/bin/bash', 15:10:11 INFO - 'SHLVL': '1', 15:10:11 INFO - 'TERM': 'linux', 15:10:11 INFO - 'TMOUT': '86400', 15:10:11 INFO - 'USER': 'cltbld', 15:10:11 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:11 INFO - '_': '/tools/buildbot/bin/python'} 15:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:11 INFO - Running setup.py (path:/tmp/pip-ksdMjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:11 INFO - Running setup.py (path:/tmp/pip-GCp7Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:11 INFO - Running setup.py (path:/tmp/pip-QXB2sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:11 INFO - Running setup.py (path:/tmp/pip-BY9hlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:11 INFO - Running setup.py (path:/tmp/pip-4CwWLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:11 INFO - Running setup.py (path:/tmp/pip-gFXEKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:11 INFO - Running setup.py (path:/tmp/pip-yIOPzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:11 INFO - Running setup.py (path:/tmp/pip-C5XLz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:11 INFO - Running setup.py (path:/tmp/pip-RRIIUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:11 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:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:11 INFO - Running setup.py (path:/tmp/pip-oNve0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:12 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:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:12 INFO - Running setup.py (path:/tmp/pip-59HjdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:12 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:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:12 INFO - Running setup.py (path:/tmp/pip-vsyubw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:12 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:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:12 INFO - Running setup.py (path:/tmp/pip-03V8oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:12 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:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:12 INFO - Running setup.py (path:/tmp/pip-m3hWyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:12 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:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:12 INFO - Running setup.py (path:/tmp/pip-UkBZ4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:12 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:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:12 INFO - Running setup.py (path:/tmp/pip-a8ZyxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:12 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:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:12 INFO - Running setup.py (path:/tmp/pip-8Jo8L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:12 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:10:12 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:10:12 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:10:12 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:10:12 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:10:12 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:10:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:12 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:10:12 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:10:12 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:10:12 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:10:12 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:10:12 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:10:14 INFO - Downloading blessings-1.5.1.tar.gz 15:10:14 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:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:10:14 INFO - Installing collected packages: blessings 15:10:14 INFO - Running setup.py install for blessings 15:10:14 INFO - Successfully installed blessings 15:10:14 INFO - Cleaning up... 15:10:14 INFO - Return code: 0 15:10:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:14 INFO - Reading from file tmpfile_stdout 15:10:14 INFO - Current package versions: 15:10:14 INFO - argparse == 1.2.1 15:10:14 INFO - blessings == 1.5.1 15:10:14 INFO - blobuploader == 1.2.4 15:10:14 INFO - docopt == 0.6.1 15:10:14 INFO - manifestparser == 1.1 15:10:14 INFO - mozInstall == 1.12 15:10:14 INFO - mozcrash == 0.16 15:10:14 INFO - mozdebug == 0.1 15:10:14 INFO - mozdevice == 0.47 15:10:14 INFO - mozfile == 1.2 15:10:14 INFO - mozhttpd == 0.7 15:10:14 INFO - mozinfo == 0.9 15:10:14 INFO - mozleak == 0.1 15:10:14 INFO - mozlog == 3.1 15:10:14 INFO - moznetwork == 0.27 15:10:14 INFO - mozprocess == 0.22 15:10:14 INFO - mozprofile == 0.28 15:10:14 INFO - mozrunner == 6.11 15:10:14 INFO - mozscreenshot == 0.1 15:10:14 INFO - mozsystemmonitor == 0.0 15:10:14 INFO - moztest == 0.7 15:10:14 INFO - mozversion == 1.4 15:10:14 INFO - psutil == 3.1.1 15:10:14 INFO - requests == 1.2.3 15:10:14 INFO - wsgiref == 0.1.2 15:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:14 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:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:14 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:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:14 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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:10:14 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:10:14 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:10:14 INFO - Using env: {'DISPLAY': ':0', 15:10:14 INFO - 'HOME': '/home/cltbld', 15:10:14 INFO - 'LANG': 'en_US.UTF-8', 15:10:14 INFO - 'LANGUAGE': 'en_US:en', 15:10:14 INFO - 'LOGNAME': 'cltbld', 15:10:14 INFO - 'MAIL': '/var/mail/cltbld', 15:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:14 INFO - 'MOZ_NO_REMOTE': '1', 15:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:14 INFO - 'NO_EM_RESTART': '1', 15:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:14 INFO - 'PWD': '/builds/slave/test', 15:10:14 INFO - 'SHELL': '/bin/bash', 15:10:14 INFO - 'SHLVL': '1', 15:10:14 INFO - 'TERM': 'linux', 15:10:14 INFO - 'TMOUT': '86400', 15:10:14 INFO - 'USER': 'cltbld', 15:10:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:14 INFO - '_': '/tools/buildbot/bin/python'} 15:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:14 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:10:14 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:10:14 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:10:14 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:10:14 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:10:14 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:10:14 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:10:14 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:10:14 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:10:14 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:10:14 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:10:14 INFO - Cleaning up... 15:10:14 INFO - Return code: 0 15:10:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:10:14 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:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:14 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:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:14 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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:10:14 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:10:14 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:10:14 INFO - Using env: {'DISPLAY': ':0', 15:10:14 INFO - 'HOME': '/home/cltbld', 15:10:14 INFO - 'LANG': 'en_US.UTF-8', 15:10:14 INFO - 'LANGUAGE': 'en_US:en', 15:10:14 INFO - 'LOGNAME': 'cltbld', 15:10:14 INFO - 'MAIL': '/var/mail/cltbld', 15:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:14 INFO - 'MOZ_NO_REMOTE': '1', 15:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:14 INFO - 'NO_EM_RESTART': '1', 15:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:14 INFO - 'PWD': '/builds/slave/test', 15:10:14 INFO - 'SHELL': '/bin/bash', 15:10:14 INFO - 'SHLVL': '1', 15:10:14 INFO - 'TERM': 'linux', 15:10:14 INFO - 'TMOUT': '86400', 15:10:14 INFO - 'USER': 'cltbld', 15:10:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:14 INFO - '_': '/tools/buildbot/bin/python'} 15:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:15 INFO - Downloading/unpacking jsonschema 15:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:10:16 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:10:16 INFO - Downloading/unpacking functools32 (from jsonschema) 15:10: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:10: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:10: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:10: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:10: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:10: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:10:16 INFO - Downloading functools32-3.2.3-2.tar.gz 15:10:16 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:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:10:17 INFO - warning: no files found matching '*.txt' 15:10:17 INFO - no previously-included directories found matching 'build' 15:10:17 INFO - no previously-included directories found matching 'dist' 15:10:17 INFO - no previously-included directories found matching '.git*' 15:10:17 INFO - Installing collected packages: jsonschema, functools32 15:10:17 INFO - Running setup.py install for functools32 15:10:17 INFO - warning: no files found matching '*.txt' 15:10:17 INFO - no previously-included directories found matching 'build' 15:10:17 INFO - no previously-included directories found matching 'dist' 15:10:17 INFO - no previously-included directories found matching '.git*' 15:10:17 INFO - Successfully installed jsonschema functools32 15:10:17 INFO - Cleaning up... 15:10:17 INFO - Return code: 0 15:10:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:10:17 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:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:17 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:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:17 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 0x7f62a88f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', '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:10:17 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:10:17 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:10:17 INFO - Using env: {'DISPLAY': ':0', 15:10:17 INFO - 'HOME': '/home/cltbld', 15:10:17 INFO - 'LANG': 'en_US.UTF-8', 15:10:17 INFO - 'LANGUAGE': 'en_US:en', 15:10:17 INFO - 'LOGNAME': 'cltbld', 15:10:17 INFO - 'MAIL': '/var/mail/cltbld', 15:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:17 INFO - 'MOZ_NO_REMOTE': '1', 15:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:17 INFO - 'NO_EM_RESTART': '1', 15:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:17 INFO - 'PWD': '/builds/slave/test', 15:10:17 INFO - 'SHELL': '/bin/bash', 15:10:17 INFO - 'SHLVL': '1', 15:10:17 INFO - 'TERM': 'linux', 15:10:17 INFO - 'TMOUT': '86400', 15:10:17 INFO - 'USER': 'cltbld', 15:10:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:17 INFO - '_': '/tools/buildbot/bin/python'} 15:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:17 INFO - Downloading/unpacking flake8 15:10:17 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:10:17 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:10:17 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:10:17 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:10:17 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:10:17 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:10:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:10:19 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:10:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:10:19 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:10:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 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:10:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:10:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:10:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:10:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:10:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:10:19 INFO - no previously-included directories found matching 'docs/_build' 15:10:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:10:19 INFO - Running setup.py install for pep8 15:10:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:10:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:10:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:10:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:10:19 INFO - no previously-included directories found matching 'docs/_build' 15:10:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:10:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:10:20 INFO - Cleaning up... 15:10:20 INFO - Return code: 0 15:10:20 INFO - Running post-action listener: _resource_record_post_action 15:10:20 INFO - Running post-action listener: _start_resource_monitoring 15:10:20 INFO - Starting resource monitoring. 15:10:20 INFO - ##### 15:10:20 INFO - ##### Running install step. 15:10:20 INFO - ##### 15:10:20 INFO - Running pre-action listener: _resource_record_pre_action 15:10:20 INFO - Running main action method: install 15:10:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:20 INFO - Reading from file tmpfile_stdout 15:10:20 INFO - Detecting whether we're running mozinstall >=1.0... 15:10:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:10:20 INFO - Reading from file tmpfile_stdout 15:10:20 INFO - Output received: 15:10:20 INFO - Usage: mozinstall [options] installer 15:10:20 INFO - Options: 15:10:20 INFO - -h, --help show this help message and exit 15:10:20 INFO - -d DEST, --destination=DEST 15:10:20 INFO - Directory to install application into. [default: 15:10:20 INFO - "/builds/slave/test"] 15:10:20 INFO - --app=APP Application being installed. [default: firefox] 15:10:20 INFO - mkdir: /builds/slave/test/build/application 15:10:20 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:10:20 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:10:35 INFO - Reading from file tmpfile_stdout 15:10:35 INFO - Output received: 15:10:35 INFO - /builds/slave/test/build/application/firefox/firefox 15:10:35 INFO - Running post-action listener: _resource_record_post_action 15:10:35 INFO - ##### 15:10:35 INFO - ##### Running run-tests step. 15:10:35 INFO - ##### 15:10:35 INFO - Running pre-action listener: _resource_record_pre_action 15:10:35 INFO - Running main action method: run_tests 15:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:10:35 INFO - Python 2.7.3 15:10:35 INFO - Return code: 0 15:10:35 INFO - grabbing minidump binary from tooltool 15:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:35 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 0x2bdf3d0>, '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 0x2b4aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:10:35 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:10:35 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:10:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:10:36 INFO - Return code: 0 15:10:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:10:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:10:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:10:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:10:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:10:37 INFO - Return code: 0 15:10:37 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/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:10:37 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/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:10:37 INFO - Using env: {'DISPLAY': ':0', 15:10:37 INFO - 'HOME': '/home/cltbld', 15:10:37 INFO - 'LANG': 'en_US.UTF-8', 15:10:37 INFO - 'LANGUAGE': 'en_US:en', 15:10:37 INFO - 'LOGNAME': 'cltbld', 15:10:37 INFO - 'MAIL': '/var/mail/cltbld', 15:10:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:10:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:37 INFO - 'MOZ_NO_REMOTE': '1', 15:10:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:37 INFO - 'NO_EM_RESTART': '1', 15:10:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:37 INFO - 'PWD': '/builds/slave/test', 15:10:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:10:37 INFO - 'SHELL': '/bin/bash', 15:10:37 INFO - 'SHLVL': '1', 15:10:37 INFO - 'TERM': 'linux', 15:10:37 INFO - 'TMOUT': '86400', 15:10:37 INFO - 'USER': 'cltbld', 15:10:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047', 15:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:37 INFO - '_': '/tools/buildbot/bin/python'} 15:10:37 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/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:10:37 INFO - mozversion application_buildid: 20160106143107 15:10:37 INFO - mozversion application_changeset: e999b2a3a76618a30d2f81b09af7ed78bdc83610 15:10:37 INFO - mozversion application_display_name: Nightly 15:10:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:10:37 INFO - mozversion application_name: Firefox 15:10:37 INFO - mozversion application_remotingname: firefox 15:10:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:10:37 INFO - mozversion application_vendor: Mozilla 15:10:37 INFO - mozversion application_version: 46.0a1 15:10:37 INFO - mozversion platform_buildid: 20160106143107 15:10:37 INFO - mozversion platform_changeset: e999b2a3a76618a30d2f81b09af7ed78bdc83610 15:10:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:10:37 INFO - mozversion platform_version: 46.0a1 15:10:37 INFO - using testdate: 1452121837 15:10:37 INFO - actual date: 1452121837 15:10:37 INFO - starting webserver on 'localhost:42646' 15:10:37 INFO - SUITE-START | Running 3 tests 15:10:37 INFO - TEST-START | dromaeo_css 15:10:37 INFO - operating with platform_type : linux_ 15:10:37 INFO - Initialising browser for dromaeo_css test... 15:10:37 INFO - TEST-INFO | started process 13486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJk178/profile http://localhost:42646/getInfo.html) 15:10:41 INFO - PROCESS | 13486 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:10:42 INFO - PROCESS | 13486 | __metrics Screen width/height:1600/1200 15:10:42 INFO - PROCESS | 13486 | colorDepth:24 15:10:42 INFO - PROCESS | 13486 | Browser inner width/height: 1024/697 15:10:42 INFO - PROCESS | 13486 | __metrics 15:10:42 INFO - PROCESS | 13486 | 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:10:43 INFO - TEST-INFO | 13486: exit 0 15:10:43 INFO - Browser initialized. 15:10:43 INFO - Running cycle 1/1 for dromaeo_css test... 15:10:43 INFO - TEST-INFO | started process 13617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJk178/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:55 INFO - PROCESS | 13617 | RSS: Main: 150196224 15:10:55 INFO - PROCESS | 13617 | 15:11:45 INFO - PROCESS | 13617 | 1452121905531 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:13:57 INFO - PROCESS | 13617 | Cycle 1(1): loaded http://localhost:42646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42646/tests/dromaeo/cssquery-ext.html) 15:13:58 INFO - PROCESS | 13617 | RSS: Main: 153661440 15:13:58 INFO - PROCESS | 13617 | 15:17:00 INFO - PROCESS | 13617 | Cycle 1(1): loaded http://localhost:42646/tests/dromaeo/cssquery-ext.html (next: http://localhost:42646/tests/dromaeo/cssquery-jquery.html) 15:17:01 INFO - PROCESS | 13617 | RSS: Main: 152952832 15:17:01 INFO - PROCESS | 13617 | 15:20:03 INFO - PROCESS | 13617 | Cycle 1(1): loaded http://localhost:42646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42646/tests/dromaeo/cssquery-mootools.html) 15:20:03 INFO - PROCESS | 13617 | RSS: Main: 154742784 15:20:03 INFO - PROCESS | 13617 | 15:23:05 INFO - PROCESS | 13617 | Cycle 1(1): loaded http://localhost:42646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42646/tests/dromaeo/cssquery-prototype.html) 15:23:06 INFO - PROCESS | 13617 | RSS: Main: 150970368 15:23:06 INFO - PROCESS | 13617 | 15:26:08 INFO - PROCESS | 13617 | Cycle 1(1): loaded http://localhost:42646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42646/tests/dromaeo/cssquery-yui.html) 15:26:09 INFO - PROCESS | 13617 | RSS: Main: 152276992 15:26:09 INFO - PROCESS | 13617 | 15:29:11 INFO - PROCESS | 13617 | Cycle 1(1): loaded http://localhost:42646/tests/dromaeo/cssquery-yui.html (next: http://localhost:42646/tests/dromaeo/cssquery-dojo.html) 15:29:12 INFO - PROCESS | 13617 | RSS: Main: 155471872 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - PROCESS | 13617 | __start_tp_report 15:29:12 INFO - PROCESS | 13617 | _x_x_mozilla_page_load 15:29:12 INFO - PROCESS | 13617 | _x_x_mozilla_page_load_details 15:29:12 INFO - PROCESS | 13617 | |i|pagename|runs| 15:29:12 INFO - PROCESS | 13617 | |0;dojo.html;2646.7353264673534;2707.837529748214;2741.0269354379193;2742.903998360058;2744.272767716555;4565.954340456595;4766.4518580363265;4782.258749893767;4821.204501257293;4830.323754674344;4721.527847215277;4743.928841067378;4761.833335833247;4818.59041981432;4824.61403087753;4414.514403415614;4434.556544345572;4449.933251001237;4472.642188624902;4523.796429160696;4531;4592.770361481913;4608.216603177468;4610.907781844361;4612.654050946176;4301.612854843048;4336.392904993303;4387;4443.133588950156;4511.233090374644;4420.447444069491;4437.356583295404;4441.111777644484;4444.93321602813;4480.171168333869;4407.625351845097;4428.247197976351;4440.933385999213;4460.553944605546;4480;4516.503184649686;4631.4442266927845;4640.489546149921;4788.377510923592;4799.304100905384;5170.922436163461;5181.922271165936;5205.427402985669;5223.608229382773;5266.078436273637;4958.851234462936;5234.214867769827;5236.136037553799;5236.895262094737;5245.029669511153;4736.59738922192;4827.637927155442;4891.877703057381;4910.410750709866;4950.529699678525;5349.759260833272;5382.703951282717;5388.757505912165;5393.892122157535;5444.673319600757;4800.711957282574;4916.901661966741;5151.712071982004;5164.070467315844;5172.27588137661;5105.106606343875;5178.223266509978;5208.0365132450615;5214.2960700304975;5286.101362768339;5097.260897169889;5138.409082955508;5142.9742851286255;5149.716765577854;5173.508516690908;4864.951350486521;5014.648974571818;5047.697138171648;5074.3657042869645;5087.109755792721;4262.488501379792;4289.935650965238;4374.956250437519;4380.080183161572;4387.627051700578;3770.3024940386117;3779.4141908004303;3787.8484860605818;3792.27946690128;3814.4850445189545;4318.719283246579;4452;4526.932096018562;4536.843105008268;4561.019380833137;5107.208382700687;5186.222066690027;5202.323697919246;5213;5235.607329450307;4505.729656220572;4515.051839113823;4527.139843429738;4550.362949187116;4557.680962332671;4441.755703436342;4558.635309175258;4643.792613920337;4671.579557839743;4679.742614156254;4733.881652958704;4756.833510827105;4807.038592281488;4822.662413631012;4849.151398505247;5134.10153223177;5136.794528218829;5142.537171654569;5145.87135321605;5161.870953226199;4752.168370535212;4844.8304309349005;4878.268259761065;4891.657583969088;4926.3349447824085;5114.923276150935;5135.589152867687;5141.2288156776785;5144.048351055067;5155.200943853709;5183.118869792069;5202.4017238016595;5202.583793296603;5220.7128607926925;5233.973830130977;4804.975975120102;4891.877703057452;4928.975355123202;5003.574696150722;5041.747912604428;5067.543921046976;5070.036693028313;5081.18701007837;5084.872878178076;5126;4959;4977.850664480072;4978.47725988766;5000.774965126505;5002.449730529566;4794.904101917872;4917.065757506062;5008.474110218374;5075.720835353944;5127.359080114986;4940.431850337113;4959.82640607577;4990.80036798524;4996.125678006407;5043.646944713835 15:29:12 INFO - PROCESS | 13617 | |1;ext.html;499.09663509048625;504.95455409013204;527.446181509415;537.4437457231764;540.5270388410142;32746.345073098524;33227.50158747621;33485.66514334856;33487.497687534706;33584.16039599011;37118.25763484729;37554.0611484713;37647.62352376482;37701.811490942506;37766;7605.315521603041;7670.731524396647;7741.729039483619;7744.148143704188;7756.534607923514;7476.962615186916;7552.5846078465665;7553.169151393342;7680.923190768077;7685.385169186479;7736.806579835521;7770.145284018753;7782.533048017109;7822.256885595859;7830.608469576527;7731.845363092735;7739.883901741478;7791.649375778104;7820.569868657221;7832.451728379016;7703.576303303316;7750.689972401097;7804.648790804427;7807.102183248942;7816.49192802466;37057.81471092654;37327.25345493102;37334.62665373339;37353.81323093394;37541.249175016346;2964.4812157872284;2971.881124755007;2990.790644654875;3241.3031198292247;3319.751018673585;26313.24146673781;28473.71526284752;28501.85749071262;28695.713042869513;28964.27589310263;3182.3317103408313;3205.3749518843833;3253.4631785755323;3270.100722301386;3376.9831150844334;217869;217990;218173;218283;218684;48857.755711221216;49837.501624983284;55553;55769;57237;50834.237486437734;51107.233391499154;51113;51238.48761512412;51367.48632513702;11972.580959666544;12154.696132596579;12178.512859485698;12184.695382615328;12214.389280536116;9418.10527999839;9519.952400238093;9529.761755956157;9534.23726101924;9535.856962145574;18849.717254241197;18923.716144257847;19672.606547868963;19811.405657830288;19849;7032.507724459341;7250.129984401906;7271.619001938528;7288.96355518219;7318.780436586911;833.2875391540267;835.8579041562949;881.6297155194834;886.1448702002598;929.0987741890356;23018.424539386648;23036.884815575813;23070.653940190576;23090;23237.3028809136;936.990630093704;956.9952150239204;997.2171845101706;1052.3370276725766;1082.5507414423084;13249.73500529984;13259.270740109387;13421.886702610565;13554.525591604246;13634.590962271148;312398;320231;322186;322767;323718;47522;47542.28686569704;47907.76046119747;47989.76005119952;48033.75983120062;1208.0818577880698;1208.8851559102047;1233.6915771057236;1239.8016317389174;1246.5450110709708;24848.751512484643;25575;25707.614385783854;25860.482790344464;25894.87052564725;37381.813090934374;37866;38279.234415312094;38315.6168438312;38410.6158938407;249694;251808;252038;252151;252486;29309;39339.2132157361;40364.79817600893;40368;40434.79782601186;34884;35991;36141.63858361488;38521.22957540889;38913.2217355657;32700.182495436853;33117;33163.66836331606;33880.83059584686;33959;37164.44253336256;39554.2089158221;39606.80196598999;39967.40048899327;40156.19687606173;35588;35784.105397365274;36188.819055904554;36209.45685814768;36454.453183201746;27547;28439.857800710863;30035.54946675758;30473;30522.694773052874;23671.408214794767;23808.16671416492;24038.51922961566;24061.27816165518;24197.395065123514 15:29:12 INFO - PROCESS | 13617 | |2;jquery.html;319.8209002958343;321.8053077887878;327.2587589110663;330.0412302261929;330.09718420120964;14831.332590033448;15078.3214755336;15277.847221527782;15999.840001599981;16490.67018659629;15364.385424583003;15796.763048554252;16113.355465781355;16319.83680163201;16511.256993435323;4638.165130276549;4770.689905156154;4771.90456190876;4772.164871147553;4775.14047471455;4658.417697787777;4684.203685373494;4695.460022097452;4698.600618947394;4702.882427939295;4554.476235232941;4689.484156742773;5326.813561525348;5497.862553436156;5512.862178445531;5331.2003199519995;5471.835844924639;5480.561555075585;5497.587680923947;5512.3385193777;4914.164592019365;4930.457649658535;4931.80272789088;4938.308636790852;4944.33251511045;11185.217034807567;11193.49629266685;11554.364509951949;11570.363630000347;11572;1732.5148958291697;1812.1935738596198;1817.4365946556477;1831.5146486181172;1840.089155867854;9151.222146117589;9342.673006444742;9362.438253704799;11707.7073073173;12005.759884802343;1659.568512186828;1668.8247733987878;1761.674090293287;1804.8826826256382;1832.6243120160334;49156.50843491555;49400.25899611509;50078;50657.98684026299;56308.43691563073;9665.806683866283;10064.194864410829;10067.345622534513;10201.591936322464;10217.540210690537;12810.359482025862;12812.231266124063;12818.67953301175;12830.230186188859;12844.357782110857;7110.431165506747;7118.608476533736;7156.856862862818;7165.570065795965;7271.490995630361;6508.511861610304;6587.176602924635;6616.768413105518;6643.634600096944;6660.433863121592;3968.1666849961252;4025.496812898388;4285.828566857291;4296.9570304297185;4347.8260869564865;1703.846653801164;1758.542778877501;1784.3308759215295;1791.9283228670706;1792.8207179281967;783.9333656639135;800.1758189065272;803.9437239393303;833.2417500075023;916.9908300917039;14247;14563.635909102357;14613.19627420502;14686.55940321792;14764.335604897591;801.310872649521;816.8938038055015;834.2658460554673;834.4200780457523;866.0386970462781;8495.830083398298;8623.180797824196;9065.81868362629;9095.636174552943;9249.491277979641;460568;471786;481627.87790915824;489173;494372;70058;72453.27546724465;72988.27011729815;73505.63247183729;73731.63134184295;1010.3786171504619;1014.6854475112887;1016.2428990402198;1024.5850430575629;1025.8358662613946;14263.500777472738;14275.64310892236;14286.357113929691;14295.57113286603;14357.138571685733;32588.511172332906;33052.83473582617;33421.16447088842;33985.47731265651;34229.48655770116;42315.57684423116;44386.334204986306;44673.776631116634;44967.7751611253;47713.5228647723;8887.511186884783;8924.643014279356;8984.55077246122;9042.321825862955;9108.362414630912;10613.734656633645;10635.14918806478;10637.042666160083;10693.304935179189;12598.181118227287;10899.509522071685;11903.82144267854;12618.621441356774;13322.467101315839;13660.180389176681;12230.816537751763;12325.137240393087;12785.552505662257;13596.728065438438;13847.723045539235;12860.871391285968;13013.739725205633;13256.403461844433;13729.313534323444;13807.240601767;8558.700445484377;8727.912720872964;8752;8794.648214071365;8823.955880220557;9304.860427093734;9329.766755831159;9344.205742511962;12396.81404778947;13357.53248636293 15:29:12 INFO - PROCESS | 13617 | |3;mootools.html;1403.038918340936;1413.886889048876;1525.4584622459026;1702.982970170298;1716.5880188754702;6456.257530384008;6550.050242714803;6563.278039415666;6727.529072964894;6838.897416538756;6731.966340168292;6790.864182716343;6828.009938558906;6839.418649414793;6842.144731908512;1966.2823069579572;2000.9199632014775;2018.5559176981042;2024.2409096588779;2030.0458784371322;1983.2562788954142;2018.7476565429322;2019.3134334326326;2038.2967876082728;2048.979510204894;1686.9915650421792;1717.450415866923;1969.1237399357292;2004.1883037369817;2038.714579958807;1976.9011549422544;1976.9505762355984;1983.9206431742714;1989.075080087766;1991.2731852873596;1929.411529483507;1952.5801952580264;2008.9497762556052;2011.054804242004;2011.8189362957405;6597.208334999783;6641.734330626769;6650.900236496456;6658.667066646648;6669.43309818666;3957.525096988351;4033.576474470168;4038;4043.2722110020186;4052.878413647595;2621.606758986148;2626.4221871188306;2663.3341664583854;2696.7572918437436;2712.22701530065;849.4096602861014;859.673324136824;864.0754392799707;864.3301441382979;887.6183241206279;8976.147266009784;8989.595468203946;9046.638134474613;9051.185393314634;9065.365424420293;3462.6191118976894;3464.3071385722956;3476.9652303477146;3517.6306487818924;3537.0626783902285;7417.406607471389;7425.405967522585;7427.108746950401;7427.554346739105;7434;4030.6573941214738;4034.596540345942;4041.413994970713;4052.209819085309;4061.025353915098;3676.7426280160666;3683.4474828775897;3683.797391143513;3685.281370132798;3708.5364329458816;2849.3873817129415;2869.885204591793;2876.6404199475064;2877.6690680571583;2882.164172390025;842.0653075086649;843.6709683223547;844.1642773654038;850.2942557677113;854.5086575219274;932.9673461428818;934.2525979216599;980.7155924781733;1128.470921900829;1131.1459847814847;6158.661273629904;6193.907091393633;6257.937420625826;6258.812235632939;6278.811635650938;1042.4058286776617;1051.8632577764843;1061.9680811283674;1064.5501802465612;1069.198101423932;4775.06886157196;4777.976110119427;4778.04439112179;4779.044191161712;4801.663883528189;7588.392928565701;7719.189485103983;7814.335781458526;7817.765467035998;7885.723999659985;7596.658150383246;7647.655855486517;7698.846023079619;7709.7301594443925;7767.883481747778;6393.328700486475;6411.134496843053;6419.45434638061;6439.581427207217;6486.708098135595;5957.165996760544;5998.130271110752;6028.849278768066;6035.849103772441;6073.757049717962;6685.231198412051;6828.897566536605;6862.691178896862;6931.410830079298;6965.44276457872;6975.3024697529845;7029.9648501757165;7032.402245809163;7132.037174981311;7176.7846964591145;6070.848228794315;6153.784617538365;6161.9691901542;6182.629042257479;6210.378962103753;6432.774852880127;6469.967650161719;6487.481001519773;6497.8700425992165;6500.382463665944;5903.852403689943;6118.990366589463;6138.263408391022;6261.405166509175;6368;5276.894462110659;5666.376698563073;6129.387061293835;6220.937790622036;6272.372762723874;5906.734196961061;5937.465628093492;5939.227900372924;6121.479674227562;6140.478059364826;5569.582281328835;5589.189567512769;5595.5803314752375;5617.354004289396;5618.381977982337;5787.9421205789085;5803.47768700819;5810.912836307543;5813.09896965971;5836.212111364912 15:29:12 INFO - PROCESS | 13617 | |4;prototype.html;287.9006742673777;290.01539772472455;293.6608217508777;297.54178565009886;297.59378448417914;5728.770849166033;5730.570207234458;5736.512396446302;5801.47786699197;5834.883302333961;5694.088945768678;5702.201691763156;5702.77188912444;5705.971470142654;5713.371529131802;4318.466944234799;4367.170237654851;4370.868873933771;4375.540568240337;4375.693701440884;4117.300058989964;4230.661547076226;4242.257604919142;4343.087951530182;4343.457067866517;4282;4294.334378171388;4317.330813723878;4338.566143385652;4346.8043938022865;4320.675949303814;4326.242907491208;4326.632236259906;4338.739675619458;4348.065165989327;3801.885943421702;3802.315583195024;3804.600516945736;3807.7144214184045;3808.0860593457646;5359.08895487768;5426.2674538937135;5482.725863706799;5490.3411590609385;5510.6418082824885;4989.525995030466;5007.098722229997;5017.473165317662;5021.472745361721;5025.723585202849;5949.46454819064;5949.464548190684;5972.104184372379;5979.461848433619;5981.401859813984;4114.177164567069;4132.690048246363;4134.937975930364;4140.855070072563;4142.772147531885;6167.136600875881;6308.936910630927;6310.211223597051;6310.495160387112;6314.368563143649;4253.97904502917;4256.616904478612;4258.787060646955;4264.360345948133;4270.167317373082;4313.913721725611;4319.222539942778;4321.719088259253;4323.221820072355;4326;4958.677685950402;4961.801527938915;4966.925496117561;4973.2540118981715;4984.950150498448;5829.300483941869;5989.790357337472;6000.699965001732;6002.669853158118;6004.849878753066;1506.2092401489087;1524.8170219573722;1527.6257316957417;1530.8239552451387;1531.1655147944398;986.4328011393477;988.7824678570703;988.7887338011022;1006.8137394582026;1009.5810238750983;5208.817691380784;5246.239295302236;5250.579953603703;5259.921716048278;5269.683818970874;6090.33006369299;6165.260168779775;6204.255489341308;6225.070228229173;6230.501559875199;5250.448702886219;5253.763580638881;5263.921041184385;5276.973615131899;5295.920561191585;3357.6306606273292;3372.072680012967;3373.7469689773366;3380.8478618462227;3380.8985730428126;5763.538916886723;5882.411758824083;5894.852628684317;5906.881862362815;5925.200097986803;6455.548111632141;6456.192975878015;6457.096006559085;6467.644279564575;6472.579282346633;5884.529237660977;5910.852228694231;5919.348871624118;5920.5559583031445;5928.347881733006;6228.968855155877;6257.43683068526;6258.43674069336;6261.530385221217;6269.31037585856;5906.852328691817;6071.817845464643;6147.415995480422;6149.2620885494025;6152.415520525543;5913.645181289136;5919.082542205792;5919.378465261086;5925.081612350093;5934.43622855828;4113.25961326964;4166.895827604334;4167.99968007682;4172.3532852407925;4182.707210495358;6175.59858609189;6250.124982502362;6285.214348206474;6303.338149494237;6312.400321969406;5998.25021872266;6046.848828779316;6055.515558755377;6066.908996364969;6071.878562428638;5922.851928701817;6026.246719160105;6031.668258245839;6037.15479832815;6044.365341639241;5808.73860676279;5907.85230369227;5920.79277225295;5921.881562368642;5935.732892019783;6001.279846418458;6073;6073.240844894388;6085;6095;5909.08409196558;5921.644701317935;5927.436893495111;5928.67392293428;5932.991391463375 15:29:12 INFO - PROCESS | 13617 | |5;yui.html;642.5277421095494;681.8499930015398;744.4305106593455;783.9608019599026;812.435357426588;11622.941885290573;11705.414729263524;11718;11729.999999999989;11745.882541174586;11283.943580282086;13358.866411335908;13578.660533486667;13624.318784060782;13672.794908076363;634.9492040636738;643.5173619785161;809.7287408718072;816.2245866426889;825.162460102996;818.7666515043214;819.1071731812324;825.5542007316042;826.0582935453588;830.6967956695793;851.0723311590365;851.8637018077109;853.3429259470204;858.0175698824842;861.1431625532604;850.4132148817328;852.54814948077;855.1149560205189;855.9614817333235;858.2061593026425;625.9530535209877;628.84593274648;629.4397985792602;631.7757196195377;635.920509936258;11983.46074426653;12041.337726425043;12079.758404831855;12093.334866582334;12108.394580271039;10794.784104317949;11761.823572646417;12178.391080445943;12227.816582751266;12481.687957801038;9304.488253146073;9405.341626086176;9611.519424028771;9922.107010369102;10000.249981251436;3185.490321548541;3237.6600456951915;3254.2189874430205;3326.7172290355347;3330.5670262865674;36180.81909590462;36454.63545364539;36779.448308275394;37220;37486.43770343447;9352.205062569758;9599.520023998772;9674.371165874336;9740.318177727491;9832.508374581243;15531.767023494656;15614;15686.450974216075;16459.25933333003;16584;6226.688665566794;6348.873022539523;6350.618962862243;6362.395572420613;6438.581492202992;3690.4279836625365;3726.1802403471193;3784.962150378516;3836.3861782114727;3946.3291240489184;2583.754543318382;2611.112221844582;2618.3061488705507;2623.553995820715;2628.9079882204414;480.22204029471783;481.91566475867285;482.85272991737855;485.8323878261994;489.69149435855184;474.8670372295763;485.34236110070344;501.9598432125421;591.4765432592101;614.827848202495;7029.507934444539;7050.92949070513;7283.126024877049;7313.524620899624;7503.887441688379;431.79705538396905;438.34686317386866;489.7208591103108;516.2591680937866;567.4609121334748;3454.762615706191;3485.581730192393;3576.964230357715;3687.391580389259;3762.811859407019;48871;49740.75129624329;49936;50055.74972125189;50171.49828501741;45424.3186352205;45508.77245613751;45534.772326138154;47273.763631182315;47550.76224618855;41512.1697566047;41905;41953;41975.370369444485;42823.999999999374;7461.701531938662;7545.170031296663;7548.8490230196185;7585;7763.2236776321915;30694.386112278076;31313.68686313199;31564.36871262516;32036.19909502281;32157.678423215468;38166.6183338163;41100;41529.37705934474;41583.37624935568;41654.37518437287;8313.667453302041;8868.068852770624;8874.423162494417;8973.416727912925;9324.813503730024;10010.099091081838;10466.110380617429;10487.26589138753;10605.681829545127;10880.945595271973;9024.097590241186;9026.323025773225;9109.18017378439;9109.77225569366;9117.36178467501;9443.340952419021;9451.149396554343;9482.905170948477;9607.951960240154;9663.661771837951;9230.35387522867;9285.675001374919;9337.813243735223;9682.903170968482;9709.56306966174;8535.573221339033;8659.13408659129;9394.765130871783;9423.796183941675;9661.661841835503;8338.708145214889;8424.83150337002;8764;8798.47209167452;8950.328725345755 15:29:12 INFO - PROCESS | 13617 | __end_tp_report 15:29:12 INFO - PROCESS | 13617 | __start_cc_report 15:29:12 INFO - PROCESS | 13617 | _x_x_mozilla_cycle_collect,322 15:29:12 INFO - PROCESS | 13617 | __end_cc_report 15:29:12 INFO - PROCESS | 13617 | __startTimestamp1452122952033__endTimestamp 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - PROCESS | 13617 | ------- Summary: start ------- 15:29:12 INFO - PROCESS | 13617 | Number of tests: 6 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - PROCESS | 13617 | [#0] dojo.html Cycles:165 Average:4767.96 Median:4864.95 stddev:502.86 (10.3%) stddev-sans-first:476.08 15:29:12 INFO - PROCESS | 13617 | Values: 2646.7 2707.8 2741.0 2742.9 2744.3 4566.0 4766.5 4782.3 4821.2 4830.3 4721.5 4743.9 4761.8 4818.6 4824.6 4414.5 4434.6 4449.9 4472.6 4523.8 4531.0 4592.8 4608.2 4610.9 4612.7 4301.6 4336.4 4387.0 4443.1 4511.2 4420.4 4437.4 4441.1 4444.9 4480.2 4407.6 4428.2 4440.9 4460.6 4480.0 4516.5 4631.4 4640.5 4788.4 4799.3 5170.9 5181.9 5205.4 5223.6 5266.1 4958.9 5234.2 5236.1 5236.9 5245.0 4736.6 4827.6 4891.9 4910.4 4950.5 5349.8 5382.7 5388.8 5393.9 5444.7 4800.7 4916.9 5151.7 5164.1 5172.3 5105.1 5178.2 5208.0 5214.3 5286.1 5097.3 5138.4 5143.0 5149.7 5173.5 4865.0 5014.6 5047.7 5074.4 5087.1 4262.5 4289.9 4375.0 4380.1 4387.6 3770.3 3779.4 3787.8 3792.3 3814.5 4318.7 4452.0 4526.9 4536.8 4561.0 5107.2 5186.2 5202.3 5213.0 5235.6 4505.7 4515.1 4527.1 4550.4 4557.7 4441.8 4558.6 4643.8 4671.6 4679.7 4733.9 4756.8 4807.0 4822.7 4849.2 5134.1 5136.8 5142.5 5145.9 5161.9 4752.2 4844.8 4878.3 4891.7 4926.3 5114.9 5135.6 5141.2 5144.0 5155.2 5183.1 5202.4 5202.6 5220.7 5234.0 4805.0 4891.9 4929.0 5003.6 5041.7 5067.5 5070.0 5081.2 5084.9 5126.0 4959.0 4977.9 4978.5 5000.8 5002.4 4794.9 4917.1 5008.5 5075.7 5127.4 4940.4 4959.8 4990.8 4996.1 5043.6 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - PROCESS | 13617 | [#1] ext.html Cycles:180 Average:42023.19 Median:36756.13 stddev:69805.18 (189.9%) stddev-sans-first:69931.38 15:29:12 INFO - PROCESS | 13617 | Values: 499.1 505.0 527.4 537.4 540.5 32746.3 33227.5 33485.7 33487.5 33584.2 37118.3 37554.1 37647.6 37701.8 37766.0 7605.3 7670.7 7741.7 7744.1 7756.5 7477.0 7552.6 7553.2 7680.9 7685.4 7736.8 7770.1 7782.5 7822.3 7830.6 7731.8 7739.9 7791.6 7820.6 7832.5 7703.6 7750.7 7804.6 7807.1 7816.5 37057.8 37327.3 37334.6 37353.8 37541.2 2964.5 2971.9 2990.8 3241.3 3319.8 26313.2 28473.7 28501.9 28695.7 28964.3 3182.3 3205.4 3253.5 3270.1 3377.0 217869.0 217990.0 218173.0 218283.0 218684.0 48857.8 49837.5 55553.0 55769.0 57237.0 50834.2 51107.2 51113.0 51238.5 51367.5 11972.6 12154.7 12178.5 12184.7 12214.4 9418.1 9520.0 9529.8 9534.2 9535.9 18849.7 18923.7 19672.6 19811.4 19849.0 7032.5 7250.1 7271.6 7289.0 7318.8 833.3 835.9 881.6 886.1 929.1 23018.4 23036.9 23070.7 23090.0 23237.3 937.0 957.0 997.2 1052.3 1082.6 13249.7 13259.3 13421.9 13554.5 13634.6 312398.0 320231.0 322186.0 322767.0 323718.0 47522.0 47542.3 47907.8 47989.8 48033.8 1208.1 1208.9 1233.7 1239.8 1246.5 24848.8 25575.0 25707.6 25860.5 25894.9 37381.8 37866.0 38279.2 38315.6 38410.6 249694.0 251808.0 252038.0 252151.0 252486.0 29309.0 39339.2 40364.8 40368.0 40434.8 34884.0 35991.0 36141.6 38521.2 38913.2 32700.2 33117.0 33163.7 33880.8 33959.0 37164.4 39554.2 39606.8 39967.4 40156.2 35588.0 35784.1 36188.8 36209.5 36454.5 27547.0 28439.9 30035.5 30473.0 30522.7 23671.4 23808.2 24038.5 24061.3 24197.4 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - PROCESS | 13617 | [#2] jquery.html Cycles:180 Average:25690.48 Median:23300.70 stddev:78387.66 (336.4%) stddev-sans-first:78584.41 15:29:12 INFO - PROCESS | 13617 | Values: 319.8 321.8 327.3 330.0 330.1 14831.3 15078.3 15277.8 15999.8 16490.7 15364.4 15796.8 16113.4 16319.8 16511.3 4638.2 4770.7 4771.9 4772.2 4775.1 4658.4 4684.2 4695.5 4698.6 4702.9 4554.5 4689.5 5326.8 5497.9 5512.9 5331.2 5471.8 5480.6 5497.6 5512.3 4914.2 4930.5 4931.8 4938.3 4944.3 11185.2 11193.5 11554.4 11570.4 11572.0 1732.5 1812.2 1817.4 1831.5 1840.1 9151.2 9342.7 9362.4 11707.7 12005.8 1659.6 1668.8 1761.7 1804.9 1832.6 49156.5 49400.3 50078.0 50658.0 56308.4 9665.8 10064.2 10067.3 10201.6 10217.5 12810.4 12812.2 12818.7 12830.2 12844.4 7110.4 7118.6 7156.9 7165.6 7271.5 6508.5 6587.2 6616.8 6643.6 6660.4 3968.2 4025.5 4285.8 4297.0 4347.8 1703.8 1758.5 1784.3 1791.9 1792.8 783.9 800.2 803.9 833.2 917.0 14247.0 14563.6 14613.2 14686.6 14764.3 801.3 816.9 834.3 834.4 866.0 8495.8 8623.2 9065.8 9095.6 9249.5 460568.0 471786.0 481627.9 489173.0 494372.0 70058.0 72453.3 72988.3 73505.6 73731.6 1010.4 1014.7 1016.2 1024.6 1025.8 14263.5 14275.6 14286.4 14295.6 14357.1 32588.5 33052.8 33421.2 33985.5 34229.5 42315.6 44386.3 44673.8 44967.8 47713.5 8887.5 8924.6 8984.6 9042.3 9108.4 10613.7 10635.1 10637.0 10693.3 12598.2 10899.5 11903.8 12618.6 13322.5 13660.2 12230.8 12325.1 12785.6 13596.7 13847.7 12860.9 13013.7 13256.4 13729.3 13807.2 8558.7 8727.9 8752.0 8794.6 8824.0 9304.9 9329.8 9344.2 12396.8 13357.5 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - PROCESS | 13617 | [#3] mootools.html Cycles:180 Average:4652.57 Median:6032.35 stddev:2368.25 (39.3%) stddev-sans-first:2362.30 15:29:12 INFO - PROCESS | 13617 | Values: 1403.0 1413.9 1525.5 1703.0 1716.6 6456.3 6550.1 6563.3 6727.5 6838.9 6732.0 6790.9 6828.0 6839.4 6842.1 1966.3 2000.9 2018.6 2024.2 2030.0 1983.3 2018.7 2019.3 2038.3 2049.0 1687.0 1717.5 1969.1 2004.2 2038.7 1976.9 1977.0 1983.9 1989.1 1991.3 1929.4 1952.6 2008.9 2011.1 2011.8 6597.2 6641.7 6650.9 6658.7 6669.4 3957.5 4033.6 4038.0 4043.3 4052.9 2621.6 2626.4 2663.3 2696.8 2712.2 849.4 859.7 864.1 864.3 887.6 8976.1 8989.6 9046.6 9051.2 9065.4 3462.6 3464.3 3477.0 3517.6 3537.1 7417.4 7425.4 7427.1 7427.6 7434.0 4030.7 4034.6 4041.4 4052.2 4061.0 3676.7 3683.4 3683.8 3685.3 3708.5 2849.4 2869.9 2876.6 2877.7 2882.2 842.1 843.7 844.2 850.3 854.5 933.0 934.3 980.7 1128.5 1131.1 6158.7 6193.9 6257.9 6258.8 6278.8 1042.4 1051.9 1062.0 1064.6 1069.2 4775.1 4778.0 4778.0 4779.0 4801.7 7588.4 7719.2 7814.3 7817.8 7885.7 7596.7 7647.7 7698.8 7709.7 7767.9 6393.3 6411.1 6419.5 6439.6 6486.7 5957.2 5998.1 6028.8 6035.8 6073.8 6685.2 6828.9 6862.7 6931.4 6965.4 6975.3 7030.0 7032.4 7132.0 7176.8 6070.8 6153.8 6162.0 6182.6 6210.4 6432.8 6470.0 6487.5 6497.9 6500.4 5903.9 6119.0 6138.3 6261.4 6368.0 5276.9 5666.4 6129.4 6220.9 6272.4 5906.7 5937.5 5939.2 6121.5 6140.5 5569.6 5589.2 5595.6 5617.4 5618.4 5787.9 5803.5 5810.9 5813.1 5836.2 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - PROCESS | 13617 | [#4] prototype.html Cycles:180 Average:4963.21 Median:5709.67 stddev:1484.30 (26.0%) stddev-sans-first:1446.39 15:29:12 INFO - PROCESS | 13617 | Values: 287.9 290.0 293.7 297.5 297.6 5728.8 5730.6 5736.5 5801.5 5834.9 5694.1 5702.2 5702.8 5706.0 5713.4 4318.5 4367.2 4370.9 4375.5 4375.7 4117.3 4230.7 4242.3 4343.1 4343.5 4282.0 4294.3 4317.3 4338.6 4346.8 4320.7 4326.2 4326.6 4338.7 4348.1 3801.9 3802.3 3804.6 3807.7 3808.1 5359.1 5426.3 5482.7 5490.3 5510.6 4989.5 5007.1 5017.5 5021.5 5025.7 5949.5 5949.5 5972.1 5979.5 5981.4 4114.2 4132.7 4134.9 4140.9 4142.8 6167.1 6308.9 6310.2 6310.5 6314.4 4254.0 4256.6 4258.8 4264.4 4270.2 4313.9 4319.2 4321.7 4323.2 4326.0 4958.7 4961.8 4966.9 4973.3 4985.0 5829.3 5989.8 6000.7 6002.7 6004.8 1506.2 1524.8 1527.6 1530.8 1531.2 986.4 988.8 988.8 1006.8 1009.6 5208.8 5246.2 5250.6 5259.9 5269.7 6090.3 6165.3 6204.3 6225.1 6230.5 5250.4 5253.8 5263.9 5277.0 5295.9 3357.6 3372.1 3373.7 3380.8 3380.9 5763.5 5882.4 5894.9 5906.9 5925.2 6455.5 6456.2 6457.1 6467.6 6472.6 5884.5 5910.9 5919.3 5920.6 5928.3 6229.0 6257.4 6258.4 6261.5 6269.3 5906.9 6071.8 6147.4 6149.3 6152.4 5913.6 5919.1 5919.4 5925.1 5934.4 4113.3 4166.9 4168.0 4172.4 4182.7 6175.6 6250.1 6285.2 6303.3 6312.4 5998.3 6046.8 6055.5 6066.9 6071.9 5922.9 6026.2 6031.7 6037.2 6044.4 5808.7 5907.9 5920.8 5921.9 5935.7 6001.3 6073.0 6073.2 6085.0 6095.0 5909.1 5921.6 5927.4 5928.7 5933.0 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - PROCESS | 13617 | [#5] yui.html Cycles:180 Average:12140.10 Median:25336.73 stddev:13927.85 (55.0%) stddev-sans-first:13940.16 15:29:12 INFO - PROCESS | 13617 | Values: 642.5 681.8 744.4 784.0 812.4 11622.9 11705.4 11718.0 11730.0 11745.9 11283.9 13358.9 13578.7 13624.3 13672.8 634.9 643.5 809.7 816.2 825.2 818.8 819.1 825.6 826.1 830.7 851.1 851.9 853.3 858.0 861.1 850.4 852.5 855.1 856.0 858.2 626.0 628.8 629.4 631.8 635.9 11983.5 12041.3 12079.8 12093.3 12108.4 10794.8 11761.8 12178.4 12227.8 12481.7 9304.5 9405.3 9611.5 9922.1 10000.2 3185.5 3237.7 3254.2 3326.7 3330.6 36180.8 36454.6 36779.4 37220.0 37486.4 9352.2 9599.5 9674.4 9740.3 9832.5 15531.8 15614.0 15686.5 16459.3 16584.0 6226.7 6348.9 6350.6 6362.4 6438.6 3690.4 3726.2 3785.0 3836.4 3946.3 2583.8 2611.1 2618.3 2623.6 2628.9 480.2 481.9 482.9 485.8 489.7 474.9 485.3 502.0 591.5 614.8 7029.5 7050.9 7283.1 7313.5 7503.9 431.8 438.3 489.7 516.3 567.5 3454.8 3485.6 3577.0 3687.4 3762.8 48871.0 49740.8 49936.0 50055.7 50171.5 45424.3 45508.8 45534.8 47273.8 47550.8 41512.2 41905.0 41953.0 41975.4 42824.0 7461.7 7545.2 7548.8 7585.0 7763.2 30694.4 31313.7 31564.4 32036.2 32157.7 38166.6 41100.0 41529.4 41583.4 41654.4 8313.7 8868.1 8874.4 8973.4 9324.8 10010.1 10466.1 10487.3 10605.7 10880.9 9024.1 9026.3 9109.2 9109.8 9117.4 9443.3 9451.1 9482.9 9608.0 9663.7 9230.4 9285.7 9337.8 9682.9 9709.6 8535.6 8659.1 9394.8 9423.8 9661.7 8338.7 8424.8 8764.0 8798.5 8950.3 15:29:12 INFO - PROCESS | 13617 | -------- Summary: end -------- 15:29:12 INFO - PROCESS | 13617 | 15:29:12 INFO - TEST-INFO | 13617: exit 0 15:29:12 INFO - TEST-OK | dromaeo_css | took 1115590ms 15:29:12 INFO - TEST-START | kraken 15:29:12 INFO - operating with platform_type : linux_ 15:29:12 INFO - Initialising browser for kraken test... 15:29:12 INFO - TEST-INFO | started process 13856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiomPR_/profile http://localhost:42646/getInfo.html) 15:29:18 INFO - PROCESS | 13856 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:29:18 INFO - PROCESS | 13856 | __metrics Screen width/height:1600/1200 15:29:18 INFO - PROCESS | 13856 | colorDepth:24 15:29:18 INFO - PROCESS | 13856 | Browser inner width/height: 1024/697 15:29:18 INFO - PROCESS | 13856 | __metrics 15:29:18 INFO - PROCESS | 13856 | 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:29:19 INFO - TEST-INFO | 13856: exit 0 15:29:19 INFO - Browser initialized. 15:29:19 INFO - Running cycle 1/1 for kraken test... 15:29:19 INFO - TEST-INFO | started process 13978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiomPR_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:31 INFO - PROCESS | 13978 | RSS: Main: 150900736 15:29:31 INFO - PROCESS | 13978 | 15:29:34 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42646/tests/kraken/driver.html?testName=audio-beat-detection) 15:29:35 INFO - PROCESS | 13978 | RSS: Main: 150347776 15:29:35 INFO - PROCESS | 13978 | 15:29:37 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42646/tests/kraken/driver.html?testName=audio-dft) 15:29:38 INFO - PROCESS | 13978 | RSS: Main: 151199744 15:29:38 INFO - PROCESS | 13978 | 15:29:41 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42646/tests/kraken/driver.html?testName=audio-fft) 15:29:42 INFO - PROCESS | 13978 | RSS: Main: 147423232 15:29:42 INFO - PROCESS | 13978 | 15:29:44 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42646/tests/kraken/driver.html?testName=audio-oscillator) 15:29:44 INFO - PROCESS | 13978 | RSS: Main: 147116032 15:29:44 INFO - PROCESS | 13978 | 15:29:46 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:29:47 INFO - PROCESS | 13978 | RSS: Main: 146837504 15:29:47 INFO - PROCESS | 13978 | 15:29:50 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42646/tests/kraken/driver.html?testName=imaging-darkroom) 15:29:51 INFO - PROCESS | 13978 | RSS: Main: 148217856 15:29:51 INFO - PROCESS | 13978 | 15:29:54 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42646/tests/kraken/driver.html?testName=imaging-desaturate) 15:29:55 INFO - PROCESS | 13978 | RSS: Main: 149397504 15:29:55 INFO - PROCESS | 13978 | 15:29:58 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42646/tests/kraken/driver.html?testName=json-parse-financial) 15:29:58 INFO - PROCESS | 13978 | RSS: Main: 148631552 15:29:58 INFO - PROCESS | 13978 | 15:30:00 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:01 INFO - PROCESS | 13978 | RSS: Main: 149516288 15:30:01 INFO - PROCESS | 13978 | 15:30:03 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42646/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:03 INFO - PROCESS | 13978 | RSS: Main: 149078016 15:30:03 INFO - PROCESS | 13978 | 15:30:05 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:06 INFO - PROCESS | 13978 | RSS: Main: 149430272 15:30:06 INFO - PROCESS | 13978 | 15:30:08 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:09 INFO - PROCESS | 13978 | RSS: Main: 148975616 15:30:09 INFO - PROCESS | 13978 | 15:30:12 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:12 INFO - PROCESS | 13978 | RSS: Main: 149254144 15:30:12 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | Cycle 1(1): loaded http://localhost:42646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42646/tests/kraken/driver.html?testName=ai-astar) 15:30:14 INFO - PROCESS | 13978 | RSS: Main: 150245376 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | __start_tp_report 15:30:14 INFO - PROCESS | 13978 | _x_x_mozilla_page_load 15:30:14 INFO - PROCESS | 13978 | _x_x_mozilla_page_load_details 15:30:14 INFO - PROCESS | 13978 | |i|pagename|runs| 15:30:14 INFO - PROCESS | 13978 | |0;ai-astar;113;108;116;113;114;123;113;113;114;114 15:30:14 INFO - PROCESS | 13978 | |1;audio-beat-detection;156;129;158;164;136;153;160;129;162;140 15:30:14 INFO - PROCESS | 13978 | |2;audio-dft;164;162;164;163;165;166;167;163;165;164 15:30:14 INFO - PROCESS | 13978 | |3;audio-fft;72;72;72;73;132;73;72;72;72;89 15:30:14 INFO - PROCESS | 13978 | |4;audio-oscillator;98;98;137;98;99;98;139;98;98;133 15:30:14 INFO - PROCESS | 13978 | |5;imaging-gaussian-blur;110;109;110;110;110;110;111;110;110;111 15:30:14 INFO - PROCESS | 13978 | |6;imaging-darkroom;148;148;149;148;147;148;149;150;149;148 15:30:14 INFO - PROCESS | 13978 | |7;imaging-desaturate;95;96;98;96;97;96;96;96;96;97 15:30:14 INFO - PROCESS | 13978 | |8;json-parse-financial;73;71;72;72;73;74;71;79;70;72 15:30:14 INFO - PROCESS | 13978 | |9;json-stringify-tinderbox;68;69;70;68;69;70;71;74;69;70 15:30:14 INFO - PROCESS | 13978 | |10;stanford-crypto-aes;83;88;84;86;86;85;87;84;85;85 15:30:14 INFO - PROCESS | 13978 | |11;stanford-crypto-ccm;134;130;129;138;122;121;119;124;130;126 15:30:14 INFO - PROCESS | 13978 | |12;stanford-crypto-pbkdf2;142;150;141;146;147;134;145;145;147;141 15:30:14 INFO - PROCESS | 13978 | |13;stanford-crypto-sha256-iterative;71;71;71;76;72;70;70;69;72;71 15:30:14 INFO - PROCESS | 13978 | __end_tp_report 15:30:14 INFO - PROCESS | 13978 | __start_cc_report 15:30:14 INFO - PROCESS | 13978 | _x_x_mozilla_cycle_collect,814 15:30:14 INFO - PROCESS | 13978 | __end_cc_report 15:30:14 INFO - PROCESS | 13978 | __startTimestamp1452123014715__endTimestamp 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | ------- Summary: start ------- 15:30:14 INFO - PROCESS | 13978 | Number of tests: 14 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:3.73 (3.3%) stddev-sans-first:3.93 15:30:14 INFO - PROCESS | 13978 | Values: 113.0 108.0 116.0 113.0 114.0 123.0 113.0 113.0 114.0 114.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:157.00 stddev:13.78 (8.8%) stddev-sans-first:14.37 15:30:14 INFO - PROCESS | 13978 | Values: 156.0 129.0 158.0 164.0 136.0 153.0 160.0 129.0 162.0 140.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:1.49 (0.9%) stddev-sans-first:1.58 15:30:14 INFO - PROCESS | 13978 | Values: 164.0 162.0 164.0 163.0 165.0 166.0 167.0 163.0 165.0 164.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#3] audio-fft Cycles:10 Average:79.90 Median:72.00 stddev:19.05 (26.5%) stddev-sans-first:19.99 15:30:14 INFO - PROCESS | 13978 | Values: 72.0 72.0 72.0 73.0 132.0 73.0 72.0 72.0 72.0 89.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:98.00 stddev:18.51 (18.9%) stddev-sans-first:19.15 15:30:14 INFO - PROCESS | 13978 | Values: 98.0 98.0 137.0 98.0 99.0 98.0 139.0 98.0 98.0 133.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:30:14 INFO - PROCESS | 13978 | Values: 110.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 111.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 15:30:14 INFO - PROCESS | 13978 | Values: 148.0 148.0 149.0 148.0 147.0 148.0 149.0 150.0 149.0 148.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 15:30:14 INFO - PROCESS | 13978 | Values: 95.0 96.0 98.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#8] json-parse-financial Cycles:10 Average:72.70 Median:72.50 stddev:2.50 (3.4%) stddev-sans-first:2.65 15:30:14 INFO - PROCESS | 13978 | Values: 73.0 71.0 72.0 72.0 73.0 74.0 71.0 79.0 70.0 72.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:1.75 (2.5%) stddev-sans-first:1.73 15:30:14 INFO - PROCESS | 13978 | Values: 68.0 69.0 70.0 68.0 69.0 70.0 71.0 74.0 69.0 70.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:1.49 (1.7%) stddev-sans-first:1.33 15:30:14 INFO - PROCESS | 13978 | Values: 83.0 88.0 84.0 86.0 86.0 85.0 87.0 84.0 85.0 85.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:129.50 stddev:6.02 (4.6%) stddev-sans-first:5.88 15:30:14 INFO - PROCESS | 13978 | Values: 134.0 130.0 129.0 138.0 122.0 121.0 119.0 124.0 130.0 126.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:145.50 stddev:4.49 (3.1%) stddev-sans-first:4.72 15:30:14 INFO - PROCESS | 13978 | Values: 142.0 150.0 141.0 146.0 147.0 134.0 145.0 145.0 147.0 141.0 15:30:14 INFO - PROCESS | 13978 | 15:30:14 INFO - PROCESS | 13978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:1.89 (2.7%) stddev-sans-first:2.00 15:30:14 INFO - PROCESS | 13978 | Values: 71.0 71.0 71.0 76.0 72.0 70.0 70.0 69.0 72.0 71.0 15:30:14 INFO - PROCESS | 13978 | -------- Summary: end -------- 15:30:14 INFO - PROCESS | 13978 | 15:30:15 INFO - TEST-INFO | 13978: exit 0 15:30:15 INFO - TEST-OK | kraken | took 62817ms 15:30:15 INFO - TEST-START | v8_7 15:30:15 INFO - operating with platform_type : linux_ 15:30:15 INFO - Initialising browser for v8_7 test... 15:30:15 INFO - TEST-INFO | started process 14264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaCL2Li/profile http://localhost:42646/getInfo.html) 15:30:20 INFO - PROCESS | 14264 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:30:21 INFO - PROCESS | 14264 | __metrics Screen width/height:1600/1200 15:30:21 INFO - PROCESS | 14264 | colorDepth:24 15:30:21 INFO - PROCESS | 14264 | Browser inner width/height: 1024/697 15:30:21 INFO - PROCESS | 14264 | __metrics 15:30:21 INFO - PROCESS | 14264 | 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:30:22 INFO - TEST-INFO | 14264: exit 0 15:30:22 INFO - Browser initialized. 15:30:22 INFO - Running cycle 1/1 for v8_7 test... 15:30:22 INFO - TEST-INFO | started process 14386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaCL2Li/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:34 INFO - PROCESS | 14386 | RSS: Main: 150577152 15:30:34 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | Cycle 1(1): loaded http://localhost:42646/tests/v8_7/run.html (next: http://localhost:42646/tests/v8_7/run.html) 15:30:56 INFO - PROCESS | 14386 | RSS: Main: 145649664 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | __start_tp_report 15:30:56 INFO - PROCESS | 14386 | _x_x_mozilla_page_load 15:30:56 INFO - PROCESS | 14386 | _x_x_mozilla_page_load_details 15:30:56 INFO - PROCESS | 14386 | |i|pagename|runs| 15:30:56 INFO - PROCESS | 14386 | |0;Richards;167.19612104999163 15:30:56 INFO - PROCESS | 14386 | |1;DeltaBlue;188.07598269700958 15:30:56 INFO - PROCESS | 14386 | |2;Encrypt;277.31558513588465 15:30:56 INFO - PROCESS | 14386 | |3;Decrypt;5164.948453608247 15:30:56 INFO - PROCESS | 14386 | |4;RayTrace;1066.0980810234541 15:30:56 INFO - PROCESS | 14386 | |5;Earley;727.2727272727273 15:30:56 INFO - PROCESS | 14386 | |6;Boyer;12444.444444444445 15:30:56 INFO - PROCESS | 14386 | |7;RegExp;25641.02564102564 15:30:56 INFO - PROCESS | 14386 | |8;Splay;601.6847172081829 15:30:56 INFO - PROCESS | 14386 | |9;NavierStokes;4840.579710144928 15:30:56 INFO - PROCESS | 14386 | __end_tp_report 15:30:56 INFO - PROCESS | 14386 | __startTimestamp1452123056265__endTimestamp 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | ------- Summary: start ------- 15:30:56 INFO - PROCESS | 14386 | Number of tests: 10 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 167.2 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#1] DeltaBlue Cycles:1 Average:188.08 Median:188.08 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 188.1 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#2] Encrypt Cycles:1 Average:277.32 Median:277.32 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 277.3 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 5164.9 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 1066.1 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#5] Earley Cycles:1 Average:727.27 Median:727.27 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 727.3 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 12444.4 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 25641.0 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#8] Splay Cycles:1 Average:601.68 Median:601.68 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 601.7 15:30:56 INFO - PROCESS | 14386 | 15:30:56 INFO - PROCESS | 14386 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 15:30:56 INFO - PROCESS | 14386 | Values: 4840.6 15:30:56 INFO - PROCESS | 14386 | -------- Summary: end -------- 15:30:56 INFO - PROCESS | 14386 | 15:30:57 INFO - TEST-INFO | 14386: exit 0 15:30:57 INFO - TEST-OK | v8_7 | took 41561ms 15:30:57 INFO - SUITE-END | took 1219s 15:30:57 INFO - Completed test suite (00:20:19) 15:30:57 INFO - Working with test: dromaeo_css 15:30:57 INFO - Generating results file: dromaeo_css 15:30:57 INFO - Working with test: kraken 15:30:57 INFO - Generating results file: kraken 15:30:57 INFO - javascript benchmark 15:30:57 INFO - Working with test: v8_7 15:30:57 INFO - Generating results file: v8_7 15:30:57 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:30:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 15:30:57 INFO - process_Request line: dromaeo_css 6274.27 graph.html#tests=[[72,132,43]] 15:30:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:30:57 INFO - process_Request line: kraken 1541.60 graph.html#tests=[[232,132,43]] 15:30:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:30:57 INFO - process_Request line: v8_7 21298.90 graph.html#tests=[[230,132,43]] 15:30:57 INFO - RETURN: dromaeo_css: 6274.27 15:30:57 INFO - RETURN: kraken: 1541.60 15:30:57 INFO - RETURN: v8_7: 21298.90 15:30:57 INFO - javascript benchmark 15:30:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2646.7353264673534, 2707.837529748214, 2741.0269354379193, 2742.903998360058, 2744.272767716555, 4565.954340456595, 4766.4518580363265, 4782.258749893767, 4821.204501257293, 4830.323754674344, 4721.527847215277, 4743.928841067378, 4761.833335833247, 4818.59041981432, 4824.61403087753, 4414.514403415614, 4434.556544345572, 4449.933251001237, 4472.642188624902, 4523.796429160696, 4531.0, 4592.770361481913, 4608.216603177468, 4610.907781844361, 4612.654050946176, 4301.612854843048, 4336.392904993303, 4387.0, 4443.133588950156, 4511.233090374644, 4420.447444069491, 4437.356583295404, 4441.111777644484, 4444.93321602813, 4480.171168333869, 4407.625351845097, 4428.247197976351, 4440.933385999213, 4460.553944605546, 4480.0, 4516.503184649686, 4631.4442266927845, 4640.489546149921, 4788.377510923592, 4799.304100905384, 5170.922436163461, 5181.922271165936, 5205.427402985669, 5223.608229382773, 5266.078436273637, 4958.851234462936, 5234.214867769827, 5236.136037553799, 5236.895262094737, 5245.029669511153, 4736.59738922192, 4827.637927155442, 4891.877703057381, 4910.410750709866, 4950.529699678525, 5349.759260833272, 5382.703951282717, 5388.757505912165, 5393.892122157535, 5444.673319600757, 4800.711957282574, 4916.901661966741, 5151.712071982004, 5164.070467315844, 5172.27588137661, 5105.106606343875, 5178.223266509978, 5208.0365132450615, 5214.2960700304975, 5286.101362768339, 5097.260897169889, 5138.409082955508, 5142.9742851286255, 5149.716765577854, 5173.508516690908, 4864.951350486521, 5014.648974571818, 5047.697138171648, 5074.3657042869645, 5087.109755792721, 4262.488501379792, 4289.935650965238, 4374.956250437519, 4380.080183161572, 4387.627051700578, 3770.3024940386117, 3779.4141908004303, 3787.8484860605818, 3792.27946690128, 3814.4850445189545, 4318.719283246579, 4452.0, 4526.932096018562, 4536.843105008268, 4561.019380833137, 5107.208382700687, 5186.222066690027, 5202.323697919246, 5213.0, 5235.607329450307, 4505.729656220572, 4515.051839113823, 4527.139843429738, 4550.362949187116, 4557.680962332671, 4441.755703436342, 4558.635309175258, 4643.792613920337, 4671.579557839743, 4679.742614156254, 4733.881652958704, 4756.833510827105, 4807.038592281488, 4822.662413631012, 4849.151398505247, 5134.10153223177, 5136.794528218829, 5142.537171654569, 5145.87135321605, 5161.870953226199, 4752.168370535212, 4844.8304309349005, 4878.268259761065, 4891.657583969088, 4926.3349447824085, 5114.923276150935, 5135.589152867687, 5141.2288156776785, 5144.048351055067, 5155.200943853709, 5183.118869792069, 5202.4017238016595, 5202.583793296603, 5220.7128607926925, 5233.973830130977, 4804.975975120102, 4891.877703057452, 4928.975355123202, 5003.574696150722, 5041.747912604428, 5067.543921046976, 5070.036693028313, 5081.18701007837, 5084.872878178076, 5126.0, 4959.0, 4977.850664480072, 4978.47725988766, 5000.774965126505, 5002.449730529566, 4794.904101917872, 4917.065757506062, 5008.474110218374, 5075.720835353944, 5127.359080114986, 4940.431850337113, 4959.82640607577, 4990.80036798524, 4996.125678006407, 5043.646944713835], "unit": "score", "name": "dojo.html", "value": 4736.1604348372275}, {"lowerIsBetter": false, "replicates": [499.09663509048625, 504.95455409013204, 527.446181509415, 537.4437457231764, 540.5270388410142, 32746.345073098524, 33227.50158747621, 33485.66514334856, 33487.497687534706, 33584.16039599011, 37118.25763484729, 37554.0611484713, 37647.62352376482, 37701.811490942506, 37766.0, 7605.315521603041, 7670.731524396647, 7741.729039483619, 7744.148143704188, 7756.534607923514, 7476.962615186916, 7552.5846078465665, 7553.169151393342, 7680.923190768077, 7685.385169186479, 7736.806579835521, 7770.145284018753, 7782.533048017109, 7822.256885595859, 7830.608469576527, 7731.845363092735, 7739.883901741478, 7791.649375778104, 7820.569868657221, 7832.451728379016, 7703.576303303316, 7750.689972401097, 7804.648790804427, 7807.102183248942, 7816.49192802466, 37057.81471092654, 37327.25345493102, 37334.62665373339, 37353.81323093394, 37541.249175016346, 2964.4812157872284, 2971.881124755007, 2990.790644654875, 3241.3031198292247, 3319.751018673585, 26313.24146673781, 28473.71526284752, 28501.85749071262, 28695.713042869513, 28964.27589310263, 3182.3317103408313, 3205.3749518843833, 3253.4631785755323, 3270.100722301386, 3376.9831150844334, 217869.0, 217990.0, 218173.0, 218283.0, 218684.0, 48857.755711221216, 49837.501624983284, 55553.0, 55769.0, 57237.0, 50834.237486437734, 51107.233391499154, 51113.0, 51238.48761512412, 51367.48632513702, 11972.580959666544, 12154.696132596579, 12178.512859485698, 12184.695382615328, 12214.389280536116, 9418.10527999839, 9519.952400238093, 9529.761755956157, 9534.23726101924, 9535.856962145574, 18849.717254241197, 18923.716144257847, 19672.606547868963, 19811.405657830288, 19849.0, 7032.507724459341, 7250.129984401906, 7271.619001938528, 7288.96355518219, 7318.780436586911, 833.2875391540267, 835.8579041562949, 881.6297155194834, 886.1448702002598, 929.0987741890356, 23018.424539386648, 23036.884815575813, 23070.653940190576, 23090.0, 23237.3028809136, 936.990630093704, 956.9952150239204, 997.2171845101706, 1052.3370276725766, 1082.5507414423084, 13249.73500529984, 13259.270740109387, 13421.886702610565, 13554.525591604246, 13634.590962271148, 312398.0, 320231.0, 322186.0, 322767.0, 323718.0, 47522.0, 47542.28686569704, 47907.76046119747, 47989.76005119952, 48033.75983120062, 1208.0818577880698, 1208.8851559102047, 1233.6915771057236, 1239.8016317389174, 1246.5450110709708, 24848.751512484643, 25575.0, 25707.614385783854, 25860.482790344464, 25894.87052564725, 37381.813090934374, 37866.0, 38279.234415312094, 38315.6168438312, 38410.6158938407, 249694.0, 251808.0, 252038.0, 252151.0, 252486.0, 29309.0, 39339.2132157361, 40364.79817600893, 40368.0, 40434.79782601186, 34884.0, 35991.0, 36141.63858361488, 38521.22957540889, 38913.2217355657, 32700.182495436853, 33117.0, 33163.66836331606, 33880.83059584686, 33959.0, 37164.44253336256, 39554.2089158221, 39606.80196598999, 39967.40048899327, 40156.19687606173, 35588.0, 35784.105397365274, 36188.819055904554, 36209.45685814768, 36454.453183201746, 27547.0, 28439.857800710863, 30035.54946675758, 30473.0, 30522.694773052874, 23671.408214794767, 23808.16671416492, 24038.51922961566, 24061.27816165518, 24197.395065123514], "unit": "score", "name": "ext.html", "value": 16718.120605559998}, {"lowerIsBetter": false, "replicates": [319.8209002958343, 321.8053077887878, 327.2587589110663, 330.0412302261929, 330.09718420120964, 14831.332590033448, 15078.3214755336, 15277.847221527782, 15999.840001599981, 16490.67018659629, 15364.385424583003, 15796.763048554252, 16113.355465781355, 16319.83680163201, 16511.256993435323, 4638.165130276549, 4770.689905156154, 4771.90456190876, 4772.164871147553, 4775.14047471455, 4658.417697787777, 4684.203685373494, 4695.460022097452, 4698.600618947394, 4702.882427939295, 4554.476235232941, 4689.484156742773, 5326.813561525348, 5497.862553436156, 5512.862178445531, 5331.2003199519995, 5471.835844924639, 5480.561555075585, 5497.587680923947, 5512.3385193777, 4914.164592019365, 4930.457649658535, 4931.80272789088, 4938.308636790852, 4944.33251511045, 11185.217034807567, 11193.49629266685, 11554.364509951949, 11570.363630000347, 11572.0, 1732.5148958291697, 1812.1935738596198, 1817.4365946556477, 1831.5146486181172, 1840.089155867854, 9151.222146117589, 9342.673006444742, 9362.438253704799, 11707.7073073173, 12005.759884802343, 1659.568512186828, 1668.8247733987878, 1761.674090293287, 1804.8826826256382, 1832.6243120160334, 49156.50843491555, 49400.25899611509, 50078.0, 50657.98684026299, 56308.43691563073, 9665.806683866283, 10064.194864410829, 10067.345622534513, 10201.591936322464, 10217.540210690537, 12810.359482025862, 12812.231266124063, 12818.67953301175, 12830.230186188859, 12844.357782110857, 7110.431165506747, 7118.608476533736, 7156.856862862818, 7165.570065795965, 7271.490995630361, 6508.511861610304, 6587.176602924635, 6616.768413105518, 6643.634600096944, 6660.433863121592, 3968.1666849961252, 4025.496812898388, 4285.828566857291, 4296.9570304297185, 4347.8260869564865, 1703.846653801164, 1758.542778877501, 1784.3308759215295, 1791.9283228670706, 1792.8207179281967, 783.9333656639135, 800.1758189065272, 803.9437239393303, 833.2417500075023, 916.9908300917039, 14247.0, 14563.635909102357, 14613.19627420502, 14686.55940321792, 14764.335604897591, 801.310872649521, 816.8938038055015, 834.2658460554673, 834.4200780457523, 866.0386970462781, 8495.830083398298, 8623.180797824196, 9065.81868362629, 9095.636174552943, 9249.491277979641, 460568.0, 471786.0, 481627.87790915824, 489173.0, 494372.0, 70058.0, 72453.27546724465, 72988.27011729815, 73505.63247183729, 73731.63134184295, 1010.3786171504619, 1014.6854475112887, 1016.2428990402198, 1024.5850430575629, 1025.8358662613946, 14263.500777472738, 14275.64310892236, 14286.357113929691, 14295.57113286603, 14357.138571685733, 32588.511172332906, 33052.83473582617, 33421.16447088842, 33985.47731265651, 34229.48655770116, 42315.57684423116, 44386.334204986306, 44673.776631116634, 44967.7751611253, 47713.5228647723, 8887.511186884783, 8924.643014279356, 8984.55077246122, 9042.321825862955, 9108.362414630912, 10613.734656633645, 10635.14918806478, 10637.042666160083, 10693.304935179189, 12598.181118227287, 10899.509522071685, 11903.82144267854, 12618.621441356774, 13322.467101315839, 13660.180389176681, 12230.816537751763, 12325.137240393087, 12785.552505662257, 13596.728065438438, 13847.723045539235, 12860.871391285968, 13013.739725205633, 13256.403461844433, 13729.313534323444, 13807.240601767, 8558.700445484377, 8727.912720872964, 8752.0, 8794.648214071365, 8823.955880220557, 9304.860427093734, 9329.766755831159, 9344.205742511962, 12396.81404778947, 13357.53248636293], "unit": "score", "name": "jquery.html", "value": 7975.636938990336}, {"lowerIsBetter": false, "replicates": [1403.038918340936, 1413.886889048876, 1525.4584622459026, 1702.982970170298, 1716.5880188754702, 6456.257530384008, 6550.050242714803, 6563.278039415666, 6727.529072964894, 6838.897416538756, 6731.966340168292, 6790.864182716343, 6828.009938558906, 6839.418649414793, 6842.144731908512, 1966.2823069579572, 2000.9199632014775, 2018.5559176981042, 2024.2409096588779, 2030.0458784371322, 1983.2562788954142, 2018.7476565429322, 2019.3134334326326, 2038.2967876082728, 2048.979510204894, 1686.9915650421792, 1717.450415866923, 1969.1237399357292, 2004.1883037369817, 2038.714579958807, 1976.9011549422544, 1976.9505762355984, 1983.9206431742714, 1989.075080087766, 1991.2731852873596, 1929.411529483507, 1952.5801952580264, 2008.9497762556052, 2011.054804242004, 2011.8189362957405, 6597.208334999783, 6641.734330626769, 6650.900236496456, 6658.667066646648, 6669.43309818666, 3957.525096988351, 4033.576474470168, 4038.0, 4043.2722110020186, 4052.878413647595, 2621.606758986148, 2626.4221871188306, 2663.3341664583854, 2696.7572918437436, 2712.22701530065, 849.4096602861014, 859.673324136824, 864.0754392799707, 864.3301441382979, 887.6183241206279, 8976.147266009784, 8989.595468203946, 9046.638134474613, 9051.185393314634, 9065.365424420293, 3462.6191118976894, 3464.3071385722956, 3476.9652303477146, 3517.6306487818924, 3537.0626783902285, 7417.406607471389, 7425.405967522585, 7427.108746950401, 7427.554346739105, 7434.0, 4030.6573941214738, 4034.596540345942, 4041.413994970713, 4052.209819085309, 4061.025353915098, 3676.7426280160666, 3683.4474828775897, 3683.797391143513, 3685.281370132798, 3708.5364329458816, 2849.3873817129415, 2869.885204591793, 2876.6404199475064, 2877.6690680571583, 2882.164172390025, 842.0653075086649, 843.6709683223547, 844.1642773654038, 850.2942557677113, 854.5086575219274, 932.9673461428818, 934.2525979216599, 980.7155924781733, 1128.470921900829, 1131.1459847814847, 6158.661273629904, 6193.907091393633, 6257.937420625826, 6258.812235632939, 6278.811635650938, 1042.4058286776617, 1051.8632577764843, 1061.9680811283674, 1064.5501802465612, 1069.198101423932, 4775.06886157196, 4777.976110119427, 4778.04439112179, 4779.044191161712, 4801.663883528189, 7588.392928565701, 7719.189485103983, 7814.335781458526, 7817.765467035998, 7885.723999659985, 7596.658150383246, 7647.655855486517, 7698.846023079619, 7709.7301594443925, 7767.883481747778, 6393.328700486475, 6411.134496843053, 6419.45434638061, 6439.581427207217, 6486.708098135595, 5957.165996760544, 5998.130271110752, 6028.849278768066, 6035.849103772441, 6073.757049717962, 6685.231198412051, 6828.897566536605, 6862.691178896862, 6931.410830079298, 6965.44276457872, 6975.3024697529845, 7029.9648501757165, 7032.402245809163, 7132.037174981311, 7176.7846964591145, 6070.848228794315, 6153.784617538365, 6161.9691901542, 6182.629042257479, 6210.378962103753, 6432.774852880127, 6469.967650161719, 6487.481001519773, 6497.8700425992165, 6500.382463665944, 5903.852403689943, 6118.990366589463, 6138.263408391022, 6261.405166509175, 6368.0, 5276.894462110659, 5666.376698563073, 6129.387061293835, 6220.937790622036, 6272.372762723874, 5906.734196961061, 5937.465628093492, 5939.227900372924, 6121.479674227562, 6140.478059364826, 5569.582281328835, 5589.189567512769, 5595.5803314752375, 5617.354004289396, 5618.381977982337, 5787.9421205789085, 5803.47768700819, 5810.912836307543, 5813.09896965971, 5836.212111364912], "unit": "score", "name": "mootools.html", "value": 3844.160116292953}, {"lowerIsBetter": false, "replicates": [287.9006742673777, 290.01539772472455, 293.6608217508777, 297.54178565009886, 297.59378448417914, 5728.770849166033, 5730.570207234458, 5736.512396446302, 5801.47786699197, 5834.883302333961, 5694.088945768678, 5702.201691763156, 5702.77188912444, 5705.971470142654, 5713.371529131802, 4318.466944234799, 4367.170237654851, 4370.868873933771, 4375.540568240337, 4375.693701440884, 4117.300058989964, 4230.661547076226, 4242.257604919142, 4343.087951530182, 4343.457067866517, 4282.0, 4294.334378171388, 4317.330813723878, 4338.566143385652, 4346.8043938022865, 4320.675949303814, 4326.242907491208, 4326.632236259906, 4338.739675619458, 4348.065165989327, 3801.885943421702, 3802.315583195024, 3804.600516945736, 3807.7144214184045, 3808.0860593457646, 5359.08895487768, 5426.2674538937135, 5482.725863706799, 5490.3411590609385, 5510.6418082824885, 4989.525995030466, 5007.098722229997, 5017.473165317662, 5021.472745361721, 5025.723585202849, 5949.46454819064, 5949.464548190684, 5972.104184372379, 5979.461848433619, 5981.401859813984, 4114.177164567069, 4132.690048246363, 4134.937975930364, 4140.855070072563, 4142.772147531885, 6167.136600875881, 6308.936910630927, 6310.211223597051, 6310.495160387112, 6314.368563143649, 4253.97904502917, 4256.616904478612, 4258.787060646955, 4264.360345948133, 4270.167317373082, 4313.913721725611, 4319.222539942778, 4321.719088259253, 4323.221820072355, 4326.0, 4958.677685950402, 4961.801527938915, 4966.925496117561, 4973.2540118981715, 4984.950150498448, 5829.300483941869, 5989.790357337472, 6000.699965001732, 6002.669853158118, 6004.849878753066, 1506.2092401489087, 1524.8170219573722, 1527.6257316957417, 1530.8239552451387, 1531.1655147944398, 986.4328011393477, 988.7824678570703, 988.7887338011022, 1006.8137394582026, 1009.5810238750983, 5208.817691380784, 5246.239295302236, 5250.579953603703, 5259.921716048278, 5269.683818970874, 6090.33006369299, 6165.260168779775, 6204.255489341308, 6225.070228229173, 6230.501559875199, 5250.448702886219, 5253.763580638881, 5263.921041184385, 5276.973615131899, 5295.920561191585, 3357.6306606273292, 3372.072680012967, 3373.7469689773366, 3380.8478618462227, 3380.8985730428126, 5763.538916886723, 5882.411758824083, 5894.852628684317, 5906.881862362815, 5925.200097986803, 6455.548111632141, 6456.192975878015, 6457.096006559085, 6467.644279564575, 6472.579282346633, 5884.529237660977, 5910.852228694231, 5919.348871624118, 5920.5559583031445, 5928.347881733006, 6228.968855155877, 6257.43683068526, 6258.43674069336, 6261.530385221217, 6269.31037585856, 5906.852328691817, 6071.817845464643, 6147.415995480422, 6149.2620885494025, 6152.415520525543, 5913.645181289136, 5919.082542205792, 5919.378465261086, 5925.081612350093, 5934.43622855828, 4113.25961326964, 4166.895827604334, 4167.99968007682, 4172.3532852407925, 4182.707210495358, 6175.59858609189, 6250.124982502362, 6285.214348206474, 6303.338149494237, 6312.400321969406, 5998.25021872266, 6046.848828779316, 6055.515558755377, 6066.908996364969, 6071.878562428638, 5922.851928701817, 6026.246719160105, 6031.668258245839, 6037.15479832815, 6044.365341639241, 5808.73860676279, 5907.85230369227, 5920.79277225295, 5921.881562368642, 5935.732892019783, 6001.279846418458, 6073.0, 6073.240844894388, 6085.0, 6095.0, 5909.08409196558, 5921.644701317935, 5927.436893495111, 5928.67392293428, 5932.991391463375], "unit": "score", "name": "prototype.html", "value": 4472.46525725924}, {"lowerIsBetter": false, "replicates": [642.5277421095494, 681.8499930015398, 744.4305106593455, 783.9608019599026, 812.435357426588, 11622.941885290573, 11705.414729263524, 11718.0, 11729.999999999989, 11745.882541174586, 11283.943580282086, 13358.866411335908, 13578.660533486667, 13624.318784060782, 13672.794908076363, 634.9492040636738, 643.5173619785161, 809.7287408718072, 816.2245866426889, 825.162460102996, 818.7666515043214, 819.1071731812324, 825.5542007316042, 826.0582935453588, 830.6967956695793, 851.0723311590365, 851.8637018077109, 853.3429259470204, 858.0175698824842, 861.1431625532604, 850.4132148817328, 852.54814948077, 855.1149560205189, 855.9614817333235, 858.2061593026425, 625.9530535209877, 628.84593274648, 629.4397985792602, 631.7757196195377, 635.920509936258, 11983.46074426653, 12041.337726425043, 12079.758404831855, 12093.334866582334, 12108.394580271039, 10794.784104317949, 11761.823572646417, 12178.391080445943, 12227.816582751266, 12481.687957801038, 9304.488253146073, 9405.341626086176, 9611.519424028771, 9922.107010369102, 10000.249981251436, 3185.490321548541, 3237.6600456951915, 3254.2189874430205, 3326.7172290355347, 3330.5670262865674, 36180.81909590462, 36454.63545364539, 36779.448308275394, 37220.0, 37486.43770343447, 9352.205062569758, 9599.520023998772, 9674.371165874336, 9740.318177727491, 9832.508374581243, 15531.767023494656, 15614.0, 15686.450974216075, 16459.25933333003, 16584.0, 6226.688665566794, 6348.873022539523, 6350.618962862243, 6362.395572420613, 6438.581492202992, 3690.4279836625365, 3726.1802403471193, 3784.962150378516, 3836.3861782114727, 3946.3291240489184, 2583.754543318382, 2611.112221844582, 2618.3061488705507, 2623.553995820715, 2628.9079882204414, 480.22204029471783, 481.91566475867285, 482.85272991737855, 485.8323878261994, 489.69149435855184, 474.8670372295763, 485.34236110070344, 501.9598432125421, 591.4765432592101, 614.827848202495, 7029.507934444539, 7050.92949070513, 7283.126024877049, 7313.524620899624, 7503.887441688379, 431.79705538396905, 438.34686317386866, 489.7208591103108, 516.2591680937866, 567.4609121334748, 3454.762615706191, 3485.581730192393, 3576.964230357715, 3687.391580389259, 3762.811859407019, 48871.0, 49740.75129624329, 49936.0, 50055.74972125189, 50171.49828501741, 45424.3186352205, 45508.77245613751, 45534.772326138154, 47273.763631182315, 47550.76224618855, 41512.1697566047, 41905.0, 41953.0, 41975.370369444485, 42823.999999999374, 7461.701531938662, 7545.170031296663, 7548.8490230196185, 7585.0, 7763.2236776321915, 30694.386112278076, 31313.68686313199, 31564.36871262516, 32036.19909502281, 32157.678423215468, 38166.6183338163, 41100.0, 41529.37705934474, 41583.37624935568, 41654.37518437287, 8313.667453302041, 8868.068852770624, 8874.423162494417, 8973.416727912925, 9324.813503730024, 10010.099091081838, 10466.110380617429, 10487.26589138753, 10605.681829545127, 10880.945595271973, 9024.097590241186, 9026.323025773225, 9109.18017378439, 9109.77225569366, 9117.36178467501, 9443.340952419021, 9451.149396554343, 9482.905170948477, 9607.951960240154, 9663.661771837951, 9230.35387522867, 9285.675001374919, 9337.813243735223, 9682.903170968482, 9709.56306966174, 8535.573221339033, 8659.13408659129, 9394.765130871783, 9423.796183941675, 9661.661841835503, 8338.708145214889, 8424.83150337002, 8764.0, 8798.47209167452, 8950.328725345755], "unit": "score", "name": "yui.html", "value": 5618.325380285952}], "name": "dromaeo_css", "value": 6274.2688634609385}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 116.0, 113.0, 114.0, 123.0, 113.0, 113.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 158.0, 164.0, 136.0, 153.0, 160.0, 129.0, 162.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 163.0, 165.0, 166.0, 167.0, 163.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 73.0, 132.0, 73.0, 72.0, 72.0, 72.0, 89.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 137.0, 98.0, 99.0, 98.0, 139.0, 98.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 149.0, 150.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 98.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 72.0, 72.0, 73.0, 74.0, 71.0, 79.0, 70.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 68.0, 69.0, 70.0, 71.0, 74.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [83.0, 88.0, 84.0, 86.0, 86.0, 85.0, 87.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [134.0, 130.0, 129.0, 138.0, 122.0, 121.0, 119.0, 124.0, 130.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [142.0, 150.0, 141.0, 146.0, 147.0, 134.0, 145.0, 145.0, 147.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 76.0, 72.0, 70.0, 70.0, 69.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1541.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [188.07598269700958], "unit": "score", "name": "DeltaBlue", "value": 351.549406}, {"lowerIsBetter": false, "replicates": [277.31558513588465], "unit": "score", "name": "Encrypt", "value": 959.8486860000002}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [727.2727272727273], "unit": "score", "name": "Earley", "value": 916.3866250000003}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [601.6847172081829], "unit": "score", "name": "Splay", "value": 135.43804200000002}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21298.904536431965}]} 15:30:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21298.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1541.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6274.27"}}} 15:30:57 INFO - Return code: 0 15:30:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:30:57 INFO - # TBPL SUCCESS # 15:30:57 INFO - Running post-action listener: _resource_record_post_action 15:30:57 INFO - Running post-run listener: _resource_record_post_run 15:30:58 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324079616; Read time: 12; Write time: 309348 15:30:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13324288; Read time: 0; Write time: 1896 15:30:58 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308043776; Read time: 12; Write time: 307248 15:30:58 INFO - Running post-run listener: _upload_blobber_files 15:30:58 INFO - Blob upload gear active. 15:30:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:58 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:30:58 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:30:58 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:30:59 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:59 INFO - (blobuploader) - INFO - Done attempting. 15:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:00 INFO - (blobuploader) - INFO - Done attempting. 15:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:31:00 INFO - Return code: 0 15:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77cdcde3c0c39c522f4adcf0ed47e2368dc0285f1d23d21e2edc68dafe41d9e8a9e65ea93d9a2e63537b7dd860d18d9f357dc14baa07855ea84d971d0beac158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4e8e336f4d2f430ca4891d26fd032cbdac332391f952ff5545c29d36d2d7b1677a9668b248cd20b36a2acc696e4c426f5540a5e1dcb95bc870aae5b8100505a"} 15:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:31:00 INFO - Contents: 15:31:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77cdcde3c0c39c522f4adcf0ed47e2368dc0285f1d23d21e2edc68dafe41d9e8a9e65ea93d9a2e63537b7dd860d18d9f357dc14baa07855ea84d971d0beac158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4e8e336f4d2f430ca4891d26fd032cbdac332391f952ff5545c29d36d2d7b1677a9668b248cd20b36a2acc696e4c426f5540a5e1dcb95bc870aae5b8100505a"} 15:31:00 INFO - Copying logs to upload dir... 15:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1349.699017 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 29 secs) (at 2016-01-06 15:31:00.766815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 15:31:00.770506) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047 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/77cdcde3c0c39c522f4adcf0ed47e2368dc0285f1d23d21e2edc68dafe41d9e8a9e65ea93d9a2e63537b7dd860d18d9f357dc14baa07855ea84d971d0beac158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4e8e336f4d2f430ca4891d26fd032cbdac332391f952ff5545c29d36d2d7b1677a9668b248cd20b36a2acc696e4c426f5540a5e1dcb95bc870aae5b8100505a"} build_url:https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/B_qCfYVsSi64-l7DxlXc8A/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/77cdcde3c0c39c522f4adcf0ed47e2368dc0285f1d23d21e2edc68dafe41d9e8a9e65ea93d9a2e63537b7dd860d18d9f357dc14baa07855ea84d971d0beac158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4e8e336f4d2f430ca4891d26fd032cbdac332391f952ff5545c29d36d2d7b1677a9668b248cd20b36a2acc696e4c426f5540a5e1dcb95bc870aae5b8100505a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 15:31:00.799714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:31:00.800426) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1452120464.647036-2040328047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 15:31:00.879834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 15:31:00.880167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 15:31:00.880476) ========= ========= Total master_lag: 0.25 =========