builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1452220171.04 results: success (0) buildid: 20160107171250 builduid: 70c993cd7000468bbb554c64b93f404e revision: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.035463) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.035858) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.036164) ========= 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=32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006348 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.060656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.060939) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.080368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.080659) ========= 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=32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.129554) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.129823) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.130164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.130444) ========= 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=32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 18:29:31-- 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% 43.6M=0s 2016-01-07 18:29:32 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.237229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.379726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.380036) ========= 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=32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018741 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:31.429774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 18:29:31.430149) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a7cc8b7aa556bd50c930f50770fa26661e41c03 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8a7cc8b7aa556bd50c930f50770fa26661e41c03 --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=32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 18:29:32,198 truncating revision to first 12 chars 2016-01-07 18:29:32,199 Setting DEBUG logging. 2016-01-07 18:29:32,199 attempt 1/10 2016-01-07 18:29:32,199 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a7cc8b7aa55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 18:29:32,887 unpacking tar archive at: mozilla-central-8a7cc8b7aa55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986890 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 18:29:32.430461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:32.430836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:32.440024) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:32.440342) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 18:29:32.440828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-07 18:29:32.441196) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:33 INFO - MultiFileLogger online at 20160107 18:29:33 in /builds/slave/test 18:29:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:29:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:33 INFO - {'append_to_log': False, 18:29:33 INFO - 'base_work_dir': '/builds/slave/test', 18:29:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:29:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:33 INFO - 'branch': 'Firefox-Non-PGO', 18:29:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:33 INFO - 'config_files': ('talos/linux_config.py',), 18:29:33 INFO - 'default_actions': ('clobber', 18:29:33 INFO - 'read-buildbot-config', 18:29:33 INFO - 'download-and-extract', 18:29:33 INFO - 'populate-webroot', 18:29:33 INFO - 'create-virtualenv', 18:29:33 INFO - 'install', 18:29:33 INFO - 'run-tests'), 18:29:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:33 INFO - 'download_minidump_stackwalk': True, 18:29:33 INFO - 'download_symbols': 'ondemand', 18:29:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:33 INFO - 'installer_path': 'installer.exe', 18:29:33 INFO - 'log_level': 'info', 18:29:33 INFO - 'log_name': 'talos', 18:29:33 INFO - 'log_to_console': True, 18:29:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:33 INFO - 'opt_config_files': (), 18:29:33 INFO - 'pip_index': False, 18:29:33 INFO - 'sps_profile': False, 18:29:33 INFO - 'sps_profile_interval': 0, 18:29:33 INFO - 'suite': 'dromaeojs', 18:29:33 INFO - 'system_bits': '32', 18:29:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:33 INFO - 'title': 'talos-linux64-ix-008', 18:29:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:33 INFO - 'use_talos_json': True, 18:29:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:33 INFO - 'work_dir': 'build'} 18:29:33 INFO - ##### 18:29:33 INFO - ##### Running clobber step. 18:29:33 INFO - ##### 18:29:33 INFO - Running pre-action listener: _resource_record_pre_action 18:29:33 INFO - Running main action method: clobber 18:29:33 INFO - rmtree: /builds/slave/test/build 18:29:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:33 INFO - Running post-action listener: _resource_record_post_action 18:29:33 INFO - ##### 18:29:33 INFO - ##### Running read-buildbot-config step. 18:29:33 INFO - ##### 18:29:33 INFO - Running pre-action listener: _resource_record_pre_action 18:29:33 INFO - Running main action method: read_buildbot_config 18:29:33 INFO - Using buildbot properties: 18:29:33 INFO - { 18:29:33 INFO - "project": "", 18:29:33 INFO - "product": "firefox", 18:29:33 INFO - "script_repo_revision": "production", 18:29:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:29:33 INFO - "repository": "", 18:29:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:29:33 INFO - "buildid": "20160107171250", 18:29:33 INFO - "pgo_build": "False", 18:29:33 INFO - "basedir": "/builds/slave/test", 18:29:33 INFO - "buildnumber": 373, 18:29:33 INFO - "slavename": "talos-linux64-ix-008", 18:29:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:29:33 INFO - "platform": "ubuntu64_hw", 18:29:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:29:33 INFO - "branch": "mozilla-central", 18:29:33 INFO - "repo_path": "mozilla-central", 18:29:33 INFO - "revision": "8a7cc8b7aa556bd50c930f50770fa26661e41c03", 18:29:33 INFO - "stage_platform": "linux64", 18:29:33 INFO - "builduid": "70c993cd7000468bbb554c64b93f404e", 18:29:33 INFO - "slavebuilddir": "test" 18:29:33 INFO - } 18:29:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:29:33 INFO - Running post-action listener: _resource_record_post_action 18:29:33 INFO - ##### 18:29:33 INFO - ##### Running download-and-extract step. 18:29:33 INFO - ##### 18:29:33 INFO - Running pre-action listener: _resource_record_pre_action 18:29:33 INFO - Running main action method: download_and_extract 18:29:33 INFO - mkdir: /builds/slave/test/build/tests 18:29:33 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')]} 18:29:33 INFO - https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:29:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/test_packages.json 18:29:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/test_packages.json 18:29:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:29:39 INFO - Downloaded 1302 bytes. 18:29:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:29:39 INFO - Using the following test package requirements: 18:29:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:29:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:39 INFO - u'jsshell-linux-x86_64.zip'], 18:29:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:29:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:29:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:29:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:29:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:29:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:29:39 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')]} 18:29:39 INFO - https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:29:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:29:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:29:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/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 18:29:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/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 18:29:45 INFO - Downloaded 22750971 bytes. 18:29:45 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 18:29:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:29:45 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 18:29:46 INFO - Return code: 0 18:29: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 18:29: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')]} 18:29:46 INFO - https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:29:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:29:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:29:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/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 18:29:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/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 18:29:48 INFO - Downloaded 22750971 bytes. 18:29:48 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 18:29:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:29:48 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 18:29:49 INFO - Return code: 0 18:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:49 INFO - https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:29:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/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 18:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/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 18:29:50 INFO - Downloaded 11132285 bytes. 18:29:50 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 18:29:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:50 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 18:29:50 INFO - Return code: 0 18:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:50 INFO - https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:29:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:29:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:29:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/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 18:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/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 18:29:51 INFO - Downloaded 54037568 bytes. 18:29:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:29:51 INFO - mkdir: /builds/slave/test/properties 18:29:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:29:51 INFO - Writing to file /builds/slave/test/properties/build_url 18:29:51 INFO - Contents: 18:29:51 INFO - build_url:https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:29:51 INFO - Running post-action listener: _resource_record_post_action 18:29:51 INFO - Running post-action listener: set_extra_try_arguments 18:29:51 INFO - ##### 18:29:51 INFO - ##### Running populate-webroot step. 18:29:51 INFO - ##### 18:29:51 INFO - Running pre-action listener: _resource_record_pre_action 18:29:51 INFO - Running main action method: populate_webroot 18:29:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:29:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:29:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:29:51 INFO - '--tppagecycles', 18:29:51 INFO - '7'], 18:29:51 INFO - 'tests': ['tsvgm']}}, 18:29:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:29:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:29:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:29:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:29:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'tests': ['damp', 'tps']}, 18:29:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['damp', 'tps']}, 18:29:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:29:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:29:51 INFO - 'other': {'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore']}, 18:29:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore']}, 18:29:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore']}, 18:29:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore']}, 18:29:51 INFO - 'other_l64': {'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore']}, 18:29:51 INFO - 'other_nol64': {'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore']}, 18:29:51 INFO - 'svgr': {'tests': ['tsvgx', 18:29:51 INFO - 'tsvgr_opacity', 18:29:51 INFO - 'tart', 18:29:51 INFO - 'tscrollx', 18:29:51 INFO - 'cart']}, 18:29:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['tsvgx', 18:29:51 INFO - 'tsvgr_opacity', 18:29:51 INFO - 'tart', 18:29:51 INFO - 'tscrollx', 18:29:51 INFO - 'cart']}, 18:29:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'tests': ['tp5o']}, 18:29:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--e10s'], 18:29:51 INFO - 'tests': ['tp5o']}, 18:29:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--xperf_path', 18:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:51 INFO - 'tests': ['tp5n']}, 18:29:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--e10s', 18:29:51 INFO - '--xperf_path', 18:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:51 INFO - 'tests': ['tp5n']}}, 18:29:51 INFO - 'talos.zip': {'path': '', 18:29:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:29:51 INFO - Running post-action listener: _resource_record_post_action 18:29:51 INFO - ##### 18:29:51 INFO - ##### Running create-virtualenv step. 18:29:51 INFO - ##### 18:29:51 INFO - Running pre-action listener: _resource_record_pre_action 18:29:51 INFO - Running main action method: create_virtualenv 18:29:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:29:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:29:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:29:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:29:51 INFO - Using real prefix '/usr' 18:29:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:29:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:29:54 INFO - Installing pip.................done. 18:29:54 INFO - Return code: 0 18:29:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:29:54 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')]} 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 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')]} 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 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 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:29:54 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 18:29:54 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 18:29:54 INFO - Using env: {'DISPLAY': ':0', 18:29:54 INFO - 'HOME': '/home/cltbld', 18:29:54 INFO - 'LANG': 'en_US.UTF-8', 18:29:54 INFO - 'LANGUAGE': 'en_US:en', 18:29:54 INFO - 'LOGNAME': 'cltbld', 18:29:54 INFO - 'MAIL': '/var/mail/cltbld', 18:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:54 INFO - 'MOZ_NO_REMOTE': '1', 18:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:54 INFO - 'NO_EM_RESTART': '1', 18:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:54 INFO - 'PWD': '/builds/slave/test', 18:29:54 INFO - 'SHELL': '/bin/bash', 18:29:54 INFO - 'SHLVL': '1', 18:29:54 INFO - 'TERM': 'linux', 18:29:54 INFO - 'TMOUT': '86400', 18:29:54 INFO - 'USER': 'cltbld', 18:29:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:54 INFO - '_': '/tools/buildbot/bin/python'} 18:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:54 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 18:29:54 INFO - Cleaning up... 18:29:54 INFO - Return code: 0 18:29:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:29:54 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')]} 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 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')]} 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 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 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:29:54 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 18:29:54 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 18:29:54 INFO - Using env: {'DISPLAY': ':0', 18:29:54 INFO - 'HOME': '/home/cltbld', 18:29:54 INFO - 'LANG': 'en_US.UTF-8', 18:29:54 INFO - 'LANGUAGE': 'en_US:en', 18:29:54 INFO - 'LOGNAME': 'cltbld', 18:29:54 INFO - 'MAIL': '/var/mail/cltbld', 18:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:54 INFO - 'MOZ_NO_REMOTE': '1', 18:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:54 INFO - 'NO_EM_RESTART': '1', 18:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:54 INFO - 'PWD': '/builds/slave/test', 18:29:54 INFO - 'SHELL': '/bin/bash', 18:29:54 INFO - 'SHLVL': '1', 18:29:54 INFO - 'TERM': 'linux', 18:29:54 INFO - 'TMOUT': '86400', 18:29:54 INFO - 'USER': 'cltbld', 18:29:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:54 INFO - '_': '/tools/buildbot/bin/python'} 18:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:54 INFO - Downloading/unpacking psutil>=0.7.1 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:29:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:29:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:56 INFO - Installing collected packages: psutil 18:29:56 INFO - Running setup.py install for psutil 18:29:56 INFO - building 'psutil._psutil_linux' extension 18:29:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:29:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:29:56 INFO - building 'psutil._psutil_posix' extension 18:29:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:29:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:57 INFO - Successfully installed psutil 18:29:57 INFO - Cleaning up... 18:29:57 INFO - Return code: 0 18:29:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:29:57 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')]} 18:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:57 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')]} 18:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:57 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 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:29:57 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 18:29:57 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 18:29:57 INFO - Using env: {'DISPLAY': ':0', 18:29:57 INFO - 'HOME': '/home/cltbld', 18:29:57 INFO - 'LANG': 'en_US.UTF-8', 18:29:57 INFO - 'LANGUAGE': 'en_US:en', 18:29:57 INFO - 'LOGNAME': 'cltbld', 18:29:57 INFO - 'MAIL': '/var/mail/cltbld', 18:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:57 INFO - 'MOZ_NO_REMOTE': '1', 18:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:57 INFO - 'NO_EM_RESTART': '1', 18:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:57 INFO - 'PWD': '/builds/slave/test', 18:29:57 INFO - 'SHELL': '/bin/bash', 18:29:57 INFO - 'SHLVL': '1', 18:29:57 INFO - 'TERM': 'linux', 18:29:57 INFO - 'TMOUT': '86400', 18:29:57 INFO - 'USER': 'cltbld', 18:29:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:57 INFO - '_': '/tools/buildbot/bin/python'} 18:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:57 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 18:29:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:29:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:29:59 INFO - Installing collected packages: mozsystemmonitor 18:29:59 INFO - Running setup.py install for mozsystemmonitor 18:29:59 INFO - Successfully installed mozsystemmonitor 18:29:59 INFO - Cleaning up... 18:29:59 INFO - Return code: 0 18:29:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:29: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')]} 18:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29: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')]} 18:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29: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', '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 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:29: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:29: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 blobuploader==1.2.4 18:29:59 INFO - Using env: {'DISPLAY': ':0', 18:29:59 INFO - 'HOME': '/home/cltbld', 18:29:59 INFO - 'LANG': 'en_US.UTF-8', 18:29:59 INFO - 'LANGUAGE': 'en_US:en', 18:29:59 INFO - 'LOGNAME': 'cltbld', 18:29:59 INFO - 'MAIL': '/var/mail/cltbld', 18:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:59 INFO - 'MOZ_NO_REMOTE': '1', 18:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:59 INFO - 'NO_EM_RESTART': '1', 18:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:59 INFO - 'PWD': '/builds/slave/test', 18:29:59 INFO - 'SHELL': '/bin/bash', 18:29:59 INFO - 'SHLVL': '1', 18:29:59 INFO - 'TERM': 'linux', 18:29:59 INFO - 'TMOUT': '86400', 18:29:59 INFO - 'USER': 'cltbld', 18:29:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:59 INFO - '_': '/tools/buildbot/bin/python'} 18:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:01 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:30:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:01 INFO - Downloading docopt-0.6.1.tar.gz 18:30:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:01 INFO - Running setup.py install for blobuploader 18:30:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:30:01 INFO - Running setup.py install for requests 18:30:02 INFO - Running setup.py install for docopt 18:30:02 INFO - Successfully installed blobuploader requests docopt 18:30:02 INFO - Cleaning up... 18:30:02 INFO - Return code: 0 18:30:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:02 INFO - Using env: {'DISPLAY': ':0', 18:30:02 INFO - 'HOME': '/home/cltbld', 18:30:02 INFO - 'LANG': 'en_US.UTF-8', 18:30:02 INFO - 'LANGUAGE': 'en_US:en', 18:30:02 INFO - 'LOGNAME': 'cltbld', 18:30:02 INFO - 'MAIL': '/var/mail/cltbld', 18:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:02 INFO - 'MOZ_NO_REMOTE': '1', 18:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:02 INFO - 'NO_EM_RESTART': '1', 18:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:02 INFO - 'PWD': '/builds/slave/test', 18:30:02 INFO - 'SHELL': '/bin/bash', 18:30:02 INFO - 'SHLVL': '1', 18:30:02 INFO - 'TERM': 'linux', 18:30:02 INFO - 'TMOUT': '86400', 18:30:02 INFO - 'USER': 'cltbld', 18:30:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:02 INFO - '_': '/tools/buildbot/bin/python'} 18:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:02 INFO - Running setup.py (path:/tmp/pip-c5SQf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:02 INFO - Running setup.py (path:/tmp/pip-QeEyMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:02 INFO - Running setup.py (path:/tmp/pip-ULRFV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:02 INFO - Running setup.py (path:/tmp/pip-VBDvP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:03 INFO - Running setup.py (path:/tmp/pip-kdGFPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:03 INFO - Running setup.py (path:/tmp/pip-u4LWmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:03 INFO - Running setup.py (path:/tmp/pip-3VPzFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:03 INFO - Running setup.py (path:/tmp/pip-1ur48Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:03 INFO - Running setup.py (path:/tmp/pip-87agbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:03 INFO - Running setup.py (path:/tmp/pip-zgKbxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:03 INFO - Running setup.py (path:/tmp/pip-KkrCdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:03 INFO - Running setup.py (path:/tmp/pip-fltbsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:03 INFO - Running setup.py (path:/tmp/pip-AGZA1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:03 INFO - Running setup.py (path:/tmp/pip-4jCfNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:03 INFO - Running setup.py (path:/tmp/pip-yZeBlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:03 INFO - Running setup.py (path:/tmp/pip-TzgiCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:03 INFO - Running setup.py (path:/tmp/pip-YYVep3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:03 INFO - Running setup.py install for manifestparser 18:30:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Running setup.py install for mozcrash 18:30:04 INFO - Running setup.py install for mozdebug 18:30:04 INFO - Running setup.py install for mozdevice 18:30:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Running setup.py install for mozfile 18:30:04 INFO - Running setup.py install for mozhttpd 18:30:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Running setup.py install for mozinfo 18:30:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Running setup.py install for mozInstall 18:30:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Running setup.py install for mozleak 18:30:04 INFO - Running setup.py install for mozlog 18:30:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:04 INFO - Running setup.py install for moznetwork 18:30:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:05 INFO - Running setup.py install for mozprocess 18:30:05 INFO - Running setup.py install for mozprofile 18:30:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:05 INFO - Running setup.py install for mozrunner 18:30:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:05 INFO - Running setup.py install for mozscreenshot 18:30:05 INFO - Running setup.py install for moztest 18:30:05 INFO - Running setup.py install for mozversion 18:30:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:05 INFO - Cleaning up... 18:30:05 INFO - Return code: 0 18:30:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:05 INFO - Using env: {'DISPLAY': ':0', 18:30:05 INFO - 'HOME': '/home/cltbld', 18:30:05 INFO - 'LANG': 'en_US.UTF-8', 18:30:05 INFO - 'LANGUAGE': 'en_US:en', 18:30:05 INFO - 'LOGNAME': 'cltbld', 18:30:05 INFO - 'MAIL': '/var/mail/cltbld', 18:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:05 INFO - 'MOZ_NO_REMOTE': '1', 18:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:05 INFO - 'NO_EM_RESTART': '1', 18:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:05 INFO - 'PWD': '/builds/slave/test', 18:30:05 INFO - 'SHELL': '/bin/bash', 18:30:05 INFO - 'SHLVL': '1', 18:30:05 INFO - 'TERM': 'linux', 18:30:05 INFO - 'TMOUT': '86400', 18:30:05 INFO - 'USER': 'cltbld', 18:30:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:05 INFO - '_': '/tools/buildbot/bin/python'} 18:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:05 INFO - Running setup.py (path:/tmp/pip-XpdxP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:05 INFO - Running setup.py (path:/tmp/pip-fAVm0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:06 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)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:06 INFO - Running setup.py (path:/tmp/pip-qwyV3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:06 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)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:06 INFO - Running setup.py (path:/tmp/pip-w6jrKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:06 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)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:06 INFO - Running setup.py (path:/tmp/pip-kzhl58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:06 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)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:06 INFO - Running setup.py (path:/tmp/pip-gbKDCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:06 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)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:06 INFO - Running setup.py (path:/tmp/pip-XwT1Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:06 INFO - Running setup.py (path:/tmp/pip-5RVl8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:06 INFO - Running setup.py (path:/tmp/pip-gB_wWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:06 INFO - Running setup.py (path:/tmp/pip-g8WPRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:06 INFO - Running setup.py (path:/tmp/pip-cvyLY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:06 INFO - Running setup.py (path:/tmp/pip-BpmPq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:06 INFO - Running setup.py (path:/tmp/pip-vj5b4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:06 INFO - Running setup.py (path:/tmp/pip-1B5IVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:06 INFO - Running setup.py (path:/tmp/pip-_9IdFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:07 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)) 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:07 INFO - Running setup.py (path:/tmp/pip-Whtk7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:07 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)) 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:07 INFO - Running setup.py (path:/tmp/pip-eB7N7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:07 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)) 18:30:07 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)) 18:30:07 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)) 18:30:07 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)) 18:30:07 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)) 18:30:07 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)) 18:30:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:07 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 18:30:07 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 18:30:07 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 18:30:07 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 18:30:07 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 18:30:07 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 18:30:08 INFO - Downloading blessings-1.5.1.tar.gz 18:30:08 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:08 INFO - Installing collected packages: blessings 18:30:08 INFO - Running setup.py install for blessings 18:30:09 INFO - Successfully installed blessings 18:30:09 INFO - Cleaning up... 18:30:09 INFO - Return code: 0 18:30:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:09 INFO - Reading from file tmpfile_stdout 18:30:09 INFO - Current package versions: 18:30:09 INFO - argparse == 1.2.1 18:30:09 INFO - blessings == 1.5.1 18:30:09 INFO - blobuploader == 1.2.4 18:30:09 INFO - docopt == 0.6.1 18:30:09 INFO - manifestparser == 1.1 18:30:09 INFO - mozInstall == 1.12 18:30:09 INFO - mozcrash == 0.16 18:30:09 INFO - mozdebug == 0.1 18:30:09 INFO - mozdevice == 0.47 18:30:09 INFO - mozfile == 1.2 18:30:09 INFO - mozhttpd == 0.7 18:30:09 INFO - mozinfo == 0.9 18:30:09 INFO - mozleak == 0.1 18:30:09 INFO - mozlog == 3.1 18:30:09 INFO - moznetwork == 0.27 18:30:09 INFO - mozprocess == 0.22 18:30:09 INFO - mozprofile == 0.28 18:30:09 INFO - mozrunner == 6.11 18:30:09 INFO - mozscreenshot == 0.1 18:30:09 INFO - mozsystemmonitor == 0.0 18:30:09 INFO - moztest == 0.7 18:30:09 INFO - mozversion == 1.4 18:30:09 INFO - psutil == 3.1.1 18:30:09 INFO - requests == 1.2.3 18:30:09 INFO - wsgiref == 0.1.2 18:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:30:09 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 18:30:09 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 18:30:09 INFO - Using env: {'DISPLAY': ':0', 18:30:09 INFO - 'HOME': '/home/cltbld', 18:30:09 INFO - 'LANG': 'en_US.UTF-8', 18:30:09 INFO - 'LANGUAGE': 'en_US:en', 18:30:09 INFO - 'LOGNAME': 'cltbld', 18:30:09 INFO - 'MAIL': '/var/mail/cltbld', 18:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:09 INFO - 'MOZ_NO_REMOTE': '1', 18:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:09 INFO - 'NO_EM_RESTART': '1', 18:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:09 INFO - 'PWD': '/builds/slave/test', 18:30:09 INFO - 'SHELL': '/bin/bash', 18:30:09 INFO - 'SHLVL': '1', 18:30:09 INFO - 'TERM': 'linux', 18:30:09 INFO - 'TMOUT': '86400', 18:30:09 INFO - 'USER': 'cltbld', 18:30:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:09 INFO - '_': '/tools/buildbot/bin/python'} 18:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:30:09 INFO - Cleaning up... 18:30:09 INFO - Return code: 0 18:30:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:30:09 INFO - Using env: {'DISPLAY': ':0', 18:30:09 INFO - 'HOME': '/home/cltbld', 18:30:09 INFO - 'LANG': 'en_US.UTF-8', 18:30:09 INFO - 'LANGUAGE': 'en_US:en', 18:30:09 INFO - 'LOGNAME': 'cltbld', 18:30:09 INFO - 'MAIL': '/var/mail/cltbld', 18:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:09 INFO - 'MOZ_NO_REMOTE': '1', 18:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:09 INFO - 'NO_EM_RESTART': '1', 18:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:09 INFO - 'PWD': '/builds/slave/test', 18:30:09 INFO - 'SHELL': '/bin/bash', 18:30:09 INFO - 'SHLVL': '1', 18:30:09 INFO - 'TERM': 'linux', 18:30:09 INFO - 'TMOUT': '86400', 18:30:09 INFO - 'USER': 'cltbld', 18:30:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:09 INFO - '_': '/tools/buildbot/bin/python'} 18:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:09 INFO - Downloading/unpacking jsonschema 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:30:11 INFO - Downloading/unpacking functools32 (from jsonschema) 18:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:11 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:11 INFO - warning: no files found matching '*.txt' 18:30:11 INFO - no previously-included directories found matching 'build' 18:30:11 INFO - no previously-included directories found matching 'dist' 18:30:11 INFO - no previously-included directories found matching '.git*' 18:30:11 INFO - Installing collected packages: jsonschema, functools32 18:30:11 INFO - Running setup.py install for functools32 18:30:11 INFO - warning: no files found matching '*.txt' 18:30:11 INFO - no previously-included directories found matching 'build' 18:30:11 INFO - no previously-included directories found matching 'dist' 18:30:11 INFO - no previously-included directories found matching '.git*' 18:30:11 INFO - Successfully installed jsonschema functools32 18:30:11 INFO - Cleaning up... 18:30:11 INFO - Return code: 0 18:30:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4db6406f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, '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': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', '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 18:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:30:11 INFO - Using env: {'DISPLAY': ':0', 18:30:11 INFO - 'HOME': '/home/cltbld', 18:30:11 INFO - 'LANG': 'en_US.UTF-8', 18:30:11 INFO - 'LANGUAGE': 'en_US:en', 18:30:11 INFO - 'LOGNAME': 'cltbld', 18:30:11 INFO - 'MAIL': '/var/mail/cltbld', 18:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:11 INFO - 'MOZ_NO_REMOTE': '1', 18:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:11 INFO - 'NO_EM_RESTART': '1', 18:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:11 INFO - 'PWD': '/builds/slave/test', 18:30:11 INFO - 'SHELL': '/bin/bash', 18:30:11 INFO - 'SHLVL': '1', 18:30:11 INFO - 'TERM': 'linux', 18:30:11 INFO - 'TMOUT': '86400', 18:30:11 INFO - 'USER': 'cltbld', 18:30:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:11 INFO - '_': '/tools/buildbot/bin/python'} 18:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:12 INFO - Downloading/unpacking flake8 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:30:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:30:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:30:14 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 18:30:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:14 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 18:30:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:30:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:30:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:30:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:30:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:30:14 INFO - no previously-included directories found matching 'docs/_build' 18:30:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:30:14 INFO - Running setup.py install for pep8 18:30:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:30:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:30:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:30:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:30:14 INFO - no previously-included directories found matching 'docs/_build' 18:30:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:30:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:30:14 INFO - Cleaning up... 18:30:14 INFO - Return code: 0 18:30:14 INFO - Running post-action listener: _resource_record_post_action 18:30:14 INFO - Running post-action listener: _start_resource_monitoring 18:30:14 INFO - Starting resource monitoring. 18:30:14 INFO - ##### 18:30:14 INFO - ##### Running install step. 18:30:14 INFO - ##### 18:30:14 INFO - Running pre-action listener: _resource_record_pre_action 18:30:14 INFO - Running main action method: install 18:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:15 INFO - Reading from file tmpfile_stdout 18:30:15 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:15 INFO - Reading from file tmpfile_stdout 18:30:15 INFO - Output received: 18:30:15 INFO - Usage: mozinstall [options] installer 18:30:15 INFO - Options: 18:30:15 INFO - -h, --help show this help message and exit 18:30:15 INFO - -d DEST, --destination=DEST 18:30:15 INFO - Directory to install application into. [default: 18:30:15 INFO - "/builds/slave/test"] 18:30:15 INFO - --app=APP Application being installed. [default: firefox] 18:30:15 INFO - mkdir: /builds/slave/test/build/application 18:30:15 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'] 18:30:15 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 18:30:30 INFO - Reading from file tmpfile_stdout 18:30:30 INFO - Output received: 18:30:30 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:30 INFO - Running post-action listener: _resource_record_post_action 18:30:30 INFO - ##### 18:30:30 INFO - ##### Running run-tests step. 18:30:30 INFO - ##### 18:30:30 INFO - Running pre-action listener: _resource_record_pre_action 18:30:30 INFO - Running main action method: run_tests 18:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:30 INFO - Python 2.7.3 18:30:30 INFO - Return code: 0 18:30:30 INFO - grabbing minidump binary from tooltool 18:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdd3d0>, '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 0x2c48ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c49360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:30:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:30:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:30 INFO - Return code: 0 18:30:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:30:31 INFO - Return code: 0 18:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:30:31 INFO - Using env: {'DISPLAY': ':0', 18:30:31 INFO - 'HOME': '/home/cltbld', 18:30:31 INFO - 'LANG': 'en_US.UTF-8', 18:30:31 INFO - 'LANGUAGE': 'en_US:en', 18:30:31 INFO - 'LOGNAME': 'cltbld', 18:30:31 INFO - 'MAIL': '/var/mail/cltbld', 18:30:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:31 INFO - 'MOZ_NO_REMOTE': '1', 18:30:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:31 INFO - 'NO_EM_RESTART': '1', 18:30:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:31 INFO - 'PWD': '/builds/slave/test', 18:30:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:31 INFO - 'SHELL': '/bin/bash', 18:30:31 INFO - 'SHLVL': '1', 18:30:31 INFO - 'TERM': 'linux', 18:30:31 INFO - 'TMOUT': '86400', 18:30:31 INFO - 'USER': 'cltbld', 18:30:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496', 18:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:31 INFO - '_': '/tools/buildbot/bin/python'} 18:30:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:30:32 INFO - mozversion application_buildid: 20160107171250 18:30:32 INFO - mozversion application_changeset: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 18:30:32 INFO - mozversion application_display_name: Nightly 18:30:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:32 INFO - mozversion application_name: Firefox 18:30:32 INFO - mozversion application_remotingname: firefox 18:30:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:30:32 INFO - mozversion application_vendor: Mozilla 18:30:32 INFO - mozversion application_version: 46.0a1 18:30:32 INFO - mozversion platform_buildid: 20160107171250 18:30:32 INFO - mozversion platform_changeset: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 18:30:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:30:32 INFO - mozversion platform_version: 46.0a1 18:30:32 INFO - using testdate: 1452220232 18:30:32 INFO - actual date: 1452220232 18:30:32 INFO - starting webserver on 'localhost:46925' 18:30:32 INFO - SUITE-START | Running 3 tests 18:30:32 INFO - TEST-START | dromaeo_css 18:30:32 INFO - operating with platform_type : linux_ 18:30:32 INFO - Initialising browser for dromaeo_css test... 18:30:32 INFO - TEST-INFO | started process 7341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5FwGx/profile http://localhost:46925/getInfo.html) 18:30:36 INFO - PROCESS | 7341 | __metrics Screen width/height:1600/1200 18:30:36 INFO - PROCESS | 7341 | colorDepth:24 18:30:36 INFO - PROCESS | 7341 | Browser inner width/height: 1024/697 18:30:36 INFO - PROCESS | 7341 | __metrics 18:30:36 INFO - PROCESS | 7341 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:30:36 INFO - PROCESS | 7341 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:30:37 INFO - TEST-INFO | 7341: exit 0 18:30:37 INFO - Browser initialized. 18:30:37 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:37 INFO - TEST-INFO | started process 7434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5FwGx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:49 INFO - PROCESS | 7434 | RSS: Main: 150933504 18:30:49 INFO - PROCESS | 7434 | 18:31:40 INFO - PROCESS | 7434 | 1452220300305 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] 18:33:51 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:46925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46925/tests/dromaeo/cssquery-ext.html) 18:33:53 INFO - PROCESS | 7434 | RSS: Main: 235601920 18:33:53 INFO - PROCESS | 7434 | 18:36:55 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:46925/tests/dromaeo/cssquery-ext.html (next: http://localhost:46925/tests/dromaeo/cssquery-jquery.html) 18:36:56 INFO - PROCESS | 7434 | RSS: Main: 226803712 18:36:56 INFO - PROCESS | 7434 | 18:39:58 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:46925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46925/tests/dromaeo/cssquery-mootools.html) 18:39:58 INFO - PROCESS | 7434 | RSS: Main: 232148992 18:39:58 INFO - PROCESS | 7434 | 18:43:00 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:46925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46925/tests/dromaeo/cssquery-prototype.html) 18:43:01 INFO - PROCESS | 7434 | RSS: Main: 214532096 18:43:01 INFO - PROCESS | 7434 | 18:46:04 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:46925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46925/tests/dromaeo/cssquery-yui.html) 18:46:04 INFO - PROCESS | 7434 | RSS: Main: 215420928 18:46:04 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:46925/tests/dromaeo/cssquery-yui.html (next: http://localhost:46925/tests/dromaeo/cssquery-dojo.html) 18:49:07 INFO - PROCESS | 7434 | RSS: Main: 259805184 18:49:07 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | __start_tp_report 18:49:07 INFO - PROCESS | 7434 | _x_x_mozilla_page_load 18:49:07 INFO - PROCESS | 7434 | _x_x_mozilla_page_load_details 18:49:07 INFO - PROCESS | 7434 | |i|pagename|runs| 18:49:07 INFO - PROCESS | 7434 | |0;dojo.html;2539.7587229213227;2635.8682065896714;2644.3785710358075;2662.5207462656726;2664.107523979467;4245.0660854612015;4400.7359558426515;4421.734695918243;4444.844430444935;4451.998300382413;4404.14119246747;4438.423005009352;4494.46066472023;4525.751083690396;4556.134334476447;3921.6862650987996;4012.558618551957;4177.16456708658;4185.288500954845;4316.525182229952;3918.1184233547365;4209.915801683965;4260.573942605745;4276.786160691969;4283.571642835707;4055.0065234017707;4089.754614723126;4172.7913604319665;4187.392828039917;4220.704550681454;4109.383592461125;4109.6506796922295;4114.19773144237;4136.896577585584;4142.378643203544;3902.2195560887653;4094.303968325362;4097.569755175723;4102.077032667626;4137.13120244749;4296.74219546825;4300.204462174476;4300.548442413533;4336.7831608419765;4350.434443522322;4650.813967441299;4679.88300292492;4789.137955168068;4795.784189711471;4829.9275510867365;4771.33201351811;4779.259214821708;4783.856484305442;4816.783244753994;4821.85534433964;4297.39836422901;4409.625181859577;4457.48738895028;4477.955220447819;4516.051629157881;4698.600618947427;4850.563449289511;4973.079980203674;4995.275685025651;4996.07572599063;4741.502142275081;4776.8566942991765;4777.378940737682;4786.377770889762;4803.087413391444;4815.927761083586;4833.154198015333;4839.564439200419;4841.636877234221;4885.877853053631;4572.4055872736335;4659.068186362741;4705.905881882411;4729.9054018920115;4869.342638743795;4728.290756386569;4729.6689231754135;4731.597814185833;4731.645126615517;4777.498362671939;4042.4946881639794;4043.211573743092;4044.211378781168;4045.1707399982934;4078.3270760324212;3446.724262059029;3500.43992961125;3547.858085676544;3567.8216089195435;3599.2441587266444;4168.416421700964;4180.414741936132;4181.540030596632;4186.539480657125;4219.029623186623;4812.51874812523;4816.397950256218;4817.710937343771;4856.344393506902;4865.9756701216265;3995.72029957906;4091.2431200227456;4094.6314831665295;4095.406166105898;4201.7268877522865;4221.409002739619;4237.364395340662;4244.342126970325;4247.936280955788;4284.250256205151;4504.234280172313;4506.954930450654;4508.504064552896;4544.1820472313975;4555.658325625592;4584.381108550303;4725.669203155746;4730.9763451182525;4732.929006064843;4764.166270902509;4544.886377840448;4560.977195114003;4575.3137029444515;4600.907981840412;4604.746738929391;4724.291356296583;4725.9054818904115;4729.030548737569;4743.075100355535;4772.856814295576;4534.115847409724;4661.137689527448;4663.743494107856;4800.903981920273;4807.062622788522;4643.4892161862845;4730.668853180245;4732.834350797705;4734.289856521412;4780.211265141352;4594.012287358234;4620.745858977789;4630.120277147466;4645.790939407667;4670.906581868411;4438.134563760165;4537.636989040935;4542.409486766699;4543.613792827647;4543.840965566189;4594.081183763194;4687.203175460112;4706.717596944194;4709.034647897104;4712.575868171881;4549.727016379028;4568.451785785594;4570.977145114253;4595.540445955377;4604.286335617984 18:49:07 INFO - PROCESS | 7434 | |1;ext.html;484.66800241834324;515.9251908473271;519.7297405349218;521.9973900130499;529.1533546325879;24524.87737561314;24791;25004.999800008;25027.74972250277;31985.680143198562;35012;35659.82170089146;35686.46470302941;35700;35715.64284357156;7499.062617172867;7687.423443241779;7721;7721.266479684421;7724.38204943606;6800.795976120699;6989.650517474131;7672.769816905474;7878.25156610124;9475.194608458289;9511.714648560554;9540.236781057498;9635.373700709431;9643.180329671986;9643.324967252294;9272.721818345426;9396.953015234949;9424.764380890463;9428.85856712143;9429.245660347156;6806.115205023315;7005.19440264371;7016.929830701679;9491.098345657152;9782.5597848097;32866.83566582176;32951.17622059444;33206.501902471486;33484.83257583697;33487.16282092943;2776.5002299586067;2781.8748156333013;2876.3528206153655;3289.4407950648447;3428.9485657715154;24215.636765448533;24607.38481537958;24654;24692.629610555858;24771.504569908502;3308.0902751743224;3340.4822252550894;3341.5655964724674;3358.1604598850286;3422.57217847769;169063.93892580186;170404;170673.99999999875;171073.14463427727;171110;45641;50125.74937125291;55022.72488637531;55086.44913550813;55190.448095519336;40520.594794052275;40758.79620601878;40902.1819563613;40920.59079409228;58421.70789146027;12435.44040518179;12545.372731363577;12613.747725045449;12710.555130570385;12747.681307967376;9610.183134433511;9611.086946740048;9680.56437460316;9716.708498745049;9723.319367644197;18095.185716642784;18308.450746477625;18332.358367457342;18353;18361.265549377877;7360.227176146427;7863.410244231591;7890.132085470594;7935.325497332791;7990.720324788605;806.4032615864219;841.6969890839293;925.9259259259227;938.737153596994;970.5875003123786;28047.439051218862;28963.275918101794;29300.56049159264;29647.110586682433;30087;920.4247345409119;961.8893827209821;980.8283550378798;1027.6300531808542;1040.2510192661273;13590.320483975762;13834.654133646538;14012.299385030708;14015.089019213718;14034.368453419416;327692;332264;333905;334779;335876.12990960665;45668.314975275396;45895.082098358514;45985.540144598126;46101.07797844092;46105;1170.0697945133638;1181.0374544746176;1183.3964678014274;1195.7249832538564;1196.491491116272;25851.482970340865;26376.60435093437;26384.472310553298;26716.332091697863;26850.865745671148;34734.47898281477;35556.111097222776;38707.80646096751;39941;41109.383359249034;202372;202923;203860;204531;205158;23533.882330588236;23998.40003999914;28189.154325370273;28758;28869.42261154723;36245;36328.81835590805;36472;37038.074048149014;37046.44430333493;27915;30164.396712066075;30167.245818854703;34187.829060854536;35793.64206357903;30466.847665762416;30801.537976930813;30830.84584577063;30972.380552388375;30987.690123099383;30081.247968800955;31119.68880311168;31159.065228043193;31172.22069448191;31234.375312493168;25977.74022259753;27971.300717482227;29842.70157298399;29859.402811944074;29870.461010813455;22057;22409.43976400603;22446.32661020172;22577.322680319616;22687.205947791746 18:49:07 INFO - PROCESS | 7434 | |2;jquery.html;330.69080409816826;331.62570841685846;332.56434071366505;333.56469806902;338.12594443363935;11946.581869634565;12350.197237179576;14542.709145817078;14880.181590012546;15454.922725386372;12337;13573.728525429486;13589.864101358984;14057.859421405783;14088.295585220749;4726.102040612282;4900.191468407708;4913.975430122844;5997.100434934751;6288;3980.721349505521;4133.813978370966;6141.078838174287;6249.87500249997;6308.684565771693;6190.969045154768;6364.077208804743;6396.808095757112;6402.93597064028;6418.261899881503;6353.714082866282;6392.3927226913365;6395.3284905084765;6410.871782564369;6410.974244120942;5820.767169313222;6346.11154438379;6351.809445716636;6352.174217351715;6354.205724284465;19768;19865.304714335074;19931.80068199314;20773.376798696063;20892;1718.2439726520415;1749.9212535435809;1761.2426656537684;1783.2688597675021;1938.2247101159649;12402.19385739924;12418.689532761662;12595.3072581008;12613.558525451657;13188.802167967488;1775.9467215983411;1828.7531183290353;1865.1047497201284;1869.803670614593;1913.5885784556249;33917.6608233917;34226.657733422595;34557.65442345595;43094.92262693426;44856.775716121534;14617.101332577935;14842;14845.628859278604;14891.32989015497;15145.772813407808;21714;21753.67369489459;21944.890275548838;22099.889500552395;22115.778842211694;7979.441439099323;7988.360931125496;8021.2379823916635;8047.678092876219;8078.151794061657;6262.718177682015;6321.747130114836;6331.841703957346;6348.396902294275;6465;6494.902576461357;7242.45681573884;7356.521826081287;7401.111866576045;7545.622718864035;1727.8876873003214;1729.0835856995811;1742.2508321421658;1745.4763570928671;2141.8500704950816;779.1585088104833;804.7505273365275;818.6357071103301;819.5082950229814;906.5603182456504;12440.937795310965;13971.301434928213;14329.426822927175;14366.281685915663;15101.622459438602;845.8519759042143;861.3324673378057;864.6282098697494;902.4404868981143;929.4237572704831;8334.958325208336;8601.5699215039;8611.138886111465;8720.084391138966;8988.370814042953;300306;305487;309463;310584;439670;54256;66562.66718666376;67003.3299666997;67093;68087.65956170188;1007.4358359318659;1012.2964539644876;1023.9827539746835;1051.6476980211562;1054.4938429553704;12890.16213946128;13210.867891320964;13567.59297221085;13898.37457314403;13911.234882081582;27098.32254193582;28064.158075257776;28304.575431368135;28402.43195136127;28773.424531508834;31401;37332.81333593423;37441;37660.43509347307;41176.794116029225;6283.748650053946;6629.966850165718;6693.464522838064;6725.293844146294;6849.48628852848;3003.05403797803;4033.910844072143;4946.703197808143;9683.709488715349;10048.648297309559;8551.871721924052;8696.913030869864;8957.14907083826;9079.046700096394;9159.084091590788;6134.447899689049;8482.448640838325;9034.909650903406;9157.725268241964;9460.95269523648;8234.300084492885;8281.012556986401;8825.20573148394;8930.955345223232;8947.552622368985;6246.781362652286;6484.967575162094;6509.804705858832;6540.803775886731;6580.234345369967;7773.883391749241;9032.954835225783;9078.773030674021;9094.954525227331;9122.221166872661 18:49:07 INFO - PROCESS | 7434 | |3;mootools.html;1208.9818652720205;1329.142702956593;1340.9798853017207;1428.8571142885712;1692.840404323039;6031.035034394497;7101;7178.9282107178915;7186.245444228359;7187.065681461409;6870.759523416681;7004.439644828414;7037.577745335284;7063.85872282554;7081.327273908983;1710.1021963469154;1739.2173521915126;2010.0753653319491;2014.5870096630156;2037.602667479842;1892.3944337811906;1894.6684330242222;1906.2756152661968;1906.5138389710605;1907.3419670213755;1962.8233458988689;1998.1407994562333;2025.9392218233477;2029.1376165129761;2029.3607513633233;2011.9094640741203;2017.122551690005;2033.9898300508478;2040.6428874946898;2042.3668662714606;1993.9800601994084;2006.8595198336122;2011.0447537419755;2013.577148798754;2016.991504247876;6943.47923905704;6974.128233970754;6978.895316570255;6984.476164287698;6995.685194166274;3895;3980.2835489611857;3986.0034991252187;4004.0790618157985;4008.4388185654034;2477.95044099117;2562.4490734492174;2593.766561009499;2617.5942728877053;2618.7250338714543;790.9011373578303;794.7695168401157;815.229608020421;821.5645707774889;822.3914303415429;8757.824843503095;8765.211130998241;8798.428102173402;8807.559622018938;8812.603432845537;3605.3690604144695;3678;3725.720570957189;3727.5713292971113;3728.813559322023;7765.883511747328;7773.844523109507;7781.06627204739;7789.805254868674;7791.142974272825;4092.7953602319767;4093.6520395766693;4097.242010228118;4097.8975525612095;4110.897227569335;3791.9810400947817;3794.8482060717815;3797.316483033025;3802.239552089593;3805.980970095132;2971.182924695726;3072.047665223743;3074.6771588983283;3443.9655603444144;3553.7157027437743;935.476133365304;942;1058.7935352606169;1076.494047797534;1079.2930630437077;1145.9140564457698;1174.5830230268132;1176.717587778944;1181.1790805390342;1204.59646018583;6223.937760622426;6279.654618995908;6320.8419789504715;6448;6470.676466176672;1032.0814475117152;1034.5499707627055;1042.2287507244585;1053.8208504554243;1054.7099547624464;5314.867128321823;5341.172118321666;5342.385625653022;5345.3852806926925;5381.3811411687375;8654.740357789276;8936.239928112831;8940.41887277338;8959.5968181432;9043;8943.016268210491;8996.59515321799;9005.054469280762;9007.324450666227;9038.86441703375;6773.830654233683;6897.241303456616;6958.686859091353;6963.373296403348;6970.79087627372;6677.866442671022;6732.192136943598;6736.7642132525125;6742.629155396304;6750.1562304711915;7903.9209607903185;7915.881261780963;7968.282854543119;8086.11052784205;8109.351251899951;8078.959605201936;8213.425060245965;8216.055153657406;8268.214519620626;8342.666293348198;6360.363963603602;6500.642464664489;6524.967375163284;6580.045893345342;6591.439727623206;6998.825029374103;7011.053507776385;7031.226565077735;7042;7057.294270572902;6714.2278637955305;6734.528582999143;6762.391384775394;6792.966035169792;6820.488463365168;5949.464548190684;6089.847753806191;6135.509159267337;6199;6282.937170628235;6150.138980542638;6213.5339849510565;6218.471429928507;6228.377162283917;6232.968835155795;5695.772169113189;5719.199312096393;5742.16738572913;5746.597738158456;5754.856128596651;5942.940570594239;6128.264608247039;6134.171886795404;6134.38656134383;6136.325004249618 18:49:07 INFO - PROCESS | 7434 | |4;prototype.html;300.05183619761556;309.6980444067035;314.33047608593705;320.31612507296927;320.7594304271796;5284;5347.652402593833;5366.409694933554;5419.512243898049;5433;5321.148616221405;5325.973370133144;5333.093374126398;5333.493318134781;5342.946570534294;3922.4900762900784;4013.5585085640555;4200.1179752252065;4207.45303110596;4209.6000879916355;4038.3538633818594;4078;4100.528439229497;4104.753714777123;4116.073883376246;4051.6556092732153;4057.229126465962;4064.471618689581;4068.4914385701786;4073.6944729145434;3871.8064096795047;3964.108075682977;4021.698372622065;4063.5936406359424;4100.138970816132;3594.3350480160993;3599.4600809878466;3600.567931848169;3613.150909536283;3617.602063772983;5075.061113693979;5085.160948443502;5174.482551744795;5184.792608295701;5188.870278243036;4748.216544270192;4761.262004389325;4764.928526072112;4766.547178018118;4769.213079841857;5488.835334939959;5607.130894711327;5611.0741727614895;5621.269234999424;5623.971880140573;4034.0519977805193;4034.838606455738;4035.3745169498775;4041.959580404188;4042.43405923171;5772.740226689809;5869.266341707286;5872.853178670524;5881.47066763989;5885.85285367865;4108.650764685035;4137.462129923151;4138.02756352257;4139.2135494256;4141.109661422748;4095.3242714952294;4191.8742437726305;4195.412642230091;4196.874093777192;4217.198732240864;4740.407449068866;4746.928796068062;4758.595519380822;4758.857234282977;4762.523747625279;5592;5598.972005139948;5639.802606908738;5640.32316122068;5640.407757185519;1474.6387135151956;1502.8046353974132;1502.8647421732096;1503.7293287208188;1505.1947208243755;1023.9846402303972;1025.4206373399006;1029.7785976015043;1038.4859494550094;1057.6404022632341;4939.580135688435;4944.456109827916;4946.9010619787405;4950.9009819803405;4954.355933728592;5830.329512106162;5835.066389377679;5835.416458354131;5837.883242335214;5840.707964601838;4919.409670839451;4938.234573641092;4945.381827271591;4949.90100197994;4953.801847926043;2902.796804223684;2972.8513574321196;3098.0396077216137;3104.379124175174;3148.5592017117624;5520.723963801875;5526.50261476469;5527.778888844482;5532.640378375393;5541.390447050821;6031.849203769941;6032.1856549365275;6034.5172386209;6037.366076561985;6039.8792024159275;5518.972405137949;5526.972365138229;5528.032594295983;5538.8061417851795;5547.639403438763;5641.435856414326;5887.941120588739;5896.469317761422;5919.733611987557;5925.377835327228;5794.681292528951;5798.15926690619;5800.738966746591;5802.709864506842;5808.7095645218415;5527.39198688152;5540.307461567304;5540.944590554042;5553.194786755978;5555.30558680165;3911.159100793343;4003.099302656879;4060.7766572837595;4066;4066.8983275417168;5824.126381042877;5837.737301821513;5837.970810145922;5890.440408161217;5891.49922256613;5622.1566764983945;5622.662640241599;5629.887402252014;5633.0987042073075;5637.689927054052;5617.578681598815;5622.943770562406;5627.606067575231;5628.746706398304;5634.183043458757;5360.43715409892;5480.6437581557075;5505.9174112387545;5509.752061157177;5515.338159420735;5616.747246373841;5647.632903861236;5651.915221271602;5652.886942261214;5658.207850900795;5240.449752775904;5337.786488540571;5367.033933891937;5444.891102178013;5483.177523371526 18:49:07 INFO - PROCESS | 7434 | |5;yui.html;691.4261163234515;717.0821348673696;749.2619769527016;762.4815125714515;765.1697907770069;11259.718507037329;11321;11552.480138393772;11563.53745850167;11595.188336816416;10694.679159625204;10735.355878647268;10745.83881241782;10764.24650274481;10765.03114719675;616.6515918506052;626.2797782550081;626.3423405424286;770.734096736625;789.1634867040955;625.6934102289867;628.6699482771536;629.4429429954478;778.9104253010892;799.5842162075717;809.9595020248964;814.0882211922655;820.6184124382161;823.0987069159261;823.5388182617753;638.5179189711738;811.0510702478115;813.8860559521672;813.894193754814;813.9470934389306;478.8898553332753;602.7528713227556;609.6068036116679;614.9538784591128;615.6060121522229;11476.254043487146;11552;11552.884471155348;11554.942225288904;11566.42167891602;10721.624743133953;10999.065079468255;11077.446127693584;11280.969952556628;11372.829407558893;9122.315826312986;9163.679271225541;9253.491057991874;9347.485888276142;9582.13760761528;3180.061881744891;3209.6629853865243;3231.8222497762613;3238.91902702432;3277.2626159114247;34968.475472867925;35180.29639407198;35195;35211;35290.82354588211;9014.86477702835;9038.231750301167;9039.728808135766;9080;9202.125798049176;15165.09009459436;15192.620184495256;15200.771988420183;15211.239438028055;15252.313645885963;6188.009918413032;6223.253209614875;6251.249850018027;6316.684165791692;6334;3377.67912048355;3405.063607507955;3421.0763093964492;3473.218525831718;3536.91157721059;2459.6679448274613;2476.1581062438495;2489.178571071542;2489.191012920808;2492.501499700067;442.5773386415965;450.27280941280253;451.9796609152596;454.80443409334305;455.81311662218997;440.8919814645432;552.259971638007;560.4647561578764;566.8582854286428;586.2993722501569;7045.89431158533;7090.610016449042;7132.393746531499;7140.321669441395;7318.707251709872;470.0622258594058;515.6957395136812;527.8231792349605;543.3371287029818;559.7900787204799;3323.516198272869;3378.6621337866018;3508.5438892944267;3518.648135186461;3531.6644918732677;45324.77337613291;45882.77058614686;45933.31100033502;46080.76959615247;46137.7693111539;41166;41477;41881.79059104685;44808.55191448109;45683.77158114188;37359.81320093382;38247.661331853255;38263.80868095697;38695.80652096721;38736.6126338733;7450.8882366763455;7480.887786683313;7577.5453472791805;7683.231676832272;7877.094134174643;28722;28763.5685464714;29035.7096429033;29548.409031818814;29695.25761855971;33711.15722106967;34492.48261276033;36603.633963660024;37169.81415092907;37426.8128659355;9460.574274157541;9461.716148515556;9500;9522.285828562746;9645.565949532147;10383.325083869524;10441.738956526147;10509.36943783345;10530;10683.091937185116;9285.350025498421;9494.525273736148;9593.808123837345;9733.318667693193;9997.350172238781;9351.298652600946;9401.52992350366;9537.14165725088;9540.189083927944;9901.207903367856;9360.20438262728;9372.250219982248;9375;9476.14714675655;9593.184579310837;8021.919780802117;8024.482146773317;8143.104258531675;8183.71357002502;8197.672093116447;8260.83478330442;8298.958505207434;8367;8675.91324086751;8833.469991800512 18:49:07 INFO - PROCESS | 7434 | __end_tp_report 18:49:07 INFO - PROCESS | 7434 | __start_cc_report 18:49:07 INFO - PROCESS | 7434 | _x_x_mozilla_cycle_collect,1013 18:49:07 INFO - PROCESS | 7434 | __end_cc_report 18:49:07 INFO - PROCESS | 7434 | __startTimestamp1452221347703__endTimestamp 18:49:07 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | ------- Summary: start ------- 18:49:07 INFO - PROCESS | 7434 | Number of tests: 6 18:49:07 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | [#0] dojo.html Cycles:165 Average:4416.39 Median:4543.84 stddev:447.66 (9.9%) stddev-sans-first:424.14 18:49:07 INFO - PROCESS | 7434 | Values: 2539.8 2635.9 2644.4 2662.5 2664.1 4245.1 4400.7 4421.7 4444.8 4452.0 4404.1 4438.4 4494.5 4525.8 4556.1 3921.7 4012.6 4177.2 4185.3 4316.5 3918.1 4209.9 4260.6 4276.8 4283.6 4055.0 4089.8 4172.8 4187.4 4220.7 4109.4 4109.7 4114.2 4136.9 4142.4 3902.2 4094.3 4097.6 4102.1 4137.1 4296.7 4300.2 4300.5 4336.8 4350.4 4650.8 4679.9 4789.1 4795.8 4829.9 4771.3 4779.3 4783.9 4816.8 4821.9 4297.4 4409.6 4457.5 4478.0 4516.1 4698.6 4850.6 4973.1 4995.3 4996.1 4741.5 4776.9 4777.4 4786.4 4803.1 4815.9 4833.2 4839.6 4841.6 4885.9 4572.4 4659.1 4705.9 4729.9 4869.3 4728.3 4729.7 4731.6 4731.6 4777.5 4042.5 4043.2 4044.2 4045.2 4078.3 3446.7 3500.4 3547.9 3567.8 3599.2 4168.4 4180.4 4181.5 4186.5 4219.0 4812.5 4816.4 4817.7 4856.3 4866.0 3995.7 4091.2 4094.6 4095.4 4201.7 4221.4 4237.4 4244.3 4247.9 4284.3 4504.2 4507.0 4508.5 4544.2 4555.7 4584.4 4725.7 4731.0 4732.9 4764.2 4544.9 4561.0 4575.3 4600.9 4604.7 4724.3 4725.9 4729.0 4743.1 4772.9 4534.1 4661.1 4663.7 4800.9 4807.1 4643.5 4730.7 4732.8 4734.3 4780.2 4594.0 4620.7 4630.1 4645.8 4670.9 4438.1 4537.6 4542.4 4543.6 4543.8 4594.1 4687.2 4706.7 4709.0 4712.6 4549.7 4568.5 4571.0 4595.5 4604.3 18:49:07 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | [#1] ext.html Cycles:180 Average:38483.27 Median:168622.74 stddev:64551.50 (38.3%) stddev-sans-first:64669.53 18:49:07 INFO - PROCESS | 7434 | Values: 484.7 515.9 519.7 522.0 529.2 24524.9 24791.0 25005.0 25027.7 31985.7 35012.0 35659.8 35686.5 35700.0 35715.6 7499.1 7687.4 7721.0 7721.3 7724.4 6800.8 6989.7 7672.8 7878.3 9475.2 9511.7 9540.2 9635.4 9643.2 9643.3 9272.7 9397.0 9424.8 9428.9 9429.2 6806.1 7005.2 7016.9 9491.1 9782.6 32866.8 32951.2 33206.5 33484.8 33487.2 2776.5 2781.9 2876.4 3289.4 3428.9 24215.6 24607.4 24654.0 24692.6 24771.5 3308.1 3340.5 3341.6 3358.2 3422.6 169063.9 170404.0 170674.0 171073.1 171110.0 45641.0 50125.7 55022.7 55086.4 55190.4 40520.6 40758.8 40902.2 40920.6 58421.7 12435.4 12545.4 12613.7 12710.6 12747.7 9610.2 9611.1 9680.6 9716.7 9723.3 18095.2 18308.5 18332.4 18353.0 18361.3 7360.2 7863.4 7890.1 7935.3 7990.7 806.4 841.7 925.9 938.7 970.6 28047.4 28963.3 29300.6 29647.1 30087.0 920.4 961.9 980.8 1027.6 1040.3 13590.3 13834.7 14012.3 14015.1 14034.4 327692.0 332264.0 333905.0 334779.0 335876.1 45668.3 45895.1 45985.5 46101.1 46105.0 1170.1 1181.0 1183.4 1195.7 1196.5 25851.5 26376.6 26384.5 26716.3 26850.9 34734.5 35556.1 38707.8 39941.0 41109.4 202372.0 202923.0 203860.0 204531.0 205158.0 23533.9 23998.4 28189.2 28758.0 28869.4 36245.0 36328.8 36472.0 37038.1 37046.4 27915.0 30164.4 30167.2 34187.8 35793.6 30466.8 30801.5 30830.8 30972.4 30987.7 30081.2 31119.7 31159.1 31172.2 31234.4 25977.7 27971.3 29842.7 29859.4 29870.5 22057.0 22409.4 22446.3 22577.3 22687.2 18:49:07 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | [#2] jquery.html Cycles:180 Average:20785.71 Median:4813.15 stddev:55177.67 (1146.4%) stddev-sans-first:55311.08 18:49:07 INFO - PROCESS | 7434 | Values: 330.7 331.6 332.6 333.6 338.1 11946.6 12350.2 14542.7 14880.2 15454.9 12337.0 13573.7 13589.9 14057.9 14088.3 4726.1 4900.2 4914.0 5997.1 6288.0 3980.7 4133.8 6141.1 6249.9 6308.7 6191.0 6364.1 6396.8 6402.9 6418.3 6353.7 6392.4 6395.3 6410.9 6411.0 5820.8 6346.1 6351.8 6352.2 6354.2 19768.0 19865.3 19931.8 20773.4 20892.0 1718.2 1749.9 1761.2 1783.3 1938.2 12402.2 12418.7 12595.3 12613.6 13188.8 1775.9 1828.8 1865.1 1869.8 1913.6 33917.7 34226.7 34557.7 43094.9 44856.8 14617.1 14842.0 14845.6 14891.3 15145.8 21714.0 21753.7 21944.9 22099.9 22115.8 7979.4 7988.4 8021.2 8047.7 8078.2 6262.7 6321.7 6331.8 6348.4 6465.0 6494.9 7242.5 7356.5 7401.1 7545.6 1727.9 1729.1 1742.3 1745.5 2141.9 779.2 804.8 818.6 819.5 906.6 12440.9 13971.3 14329.4 14366.3 15101.6 845.9 861.3 864.6 902.4 929.4 8335.0 8601.6 8611.1 8720.1 8988.4 300306.0 305487.0 309463.0 310584.0 439670.0 54256.0 66562.7 67003.3 67093.0 68087.7 1007.4 1012.3 1024.0 1051.6 1054.5 12890.2 13210.9 13567.6 13898.4 13911.2 27098.3 28064.2 28304.6 28402.4 28773.4 31401.0 37332.8 37441.0 37660.4 41176.8 6283.7 6630.0 6693.5 6725.3 6849.5 3003.1 4033.9 4946.7 9683.7 10048.6 8551.9 8696.9 8957.1 9079.0 9159.1 6134.4 8482.4 9034.9 9157.7 9461.0 8234.3 8281.0 8825.2 8931.0 8947.6 6246.8 6485.0 6509.8 6540.8 6580.2 7773.9 9033.0 9078.8 9095.0 9122.2 18:49:07 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | [#3] mootools.html Cycles:180 Average:4946.78 Median:6135.92 stddev:2610.14 (42.5%) stddev-sans-first:2602.34 18:49:07 INFO - PROCESS | 7434 | Values: 1209.0 1329.1 1341.0 1428.9 1692.8 6031.0 7101.0 7178.9 7186.2 7187.1 6870.8 7004.4 7037.6 7063.9 7081.3 1710.1 1739.2 2010.1 2014.6 2037.6 1892.4 1894.7 1906.3 1906.5 1907.3 1962.8 1998.1 2025.9 2029.1 2029.4 2011.9 2017.1 2034.0 2040.6 2042.4 1994.0 2006.9 2011.0 2013.6 2017.0 6943.5 6974.1 6978.9 6984.5 6995.7 3895.0 3980.3 3986.0 4004.1 4008.4 2478.0 2562.4 2593.8 2617.6 2618.7 790.9 794.8 815.2 821.6 822.4 8757.8 8765.2 8798.4 8807.6 8812.6 3605.4 3678.0 3725.7 3727.6 3728.8 7765.9 7773.8 7781.1 7789.8 7791.1 4092.8 4093.7 4097.2 4097.9 4110.9 3792.0 3794.8 3797.3 3802.2 3806.0 2971.2 3072.0 3074.7 3444.0 3553.7 935.5 942.0 1058.8 1076.5 1079.3 1145.9 1174.6 1176.7 1181.2 1204.6 6223.9 6279.7 6320.8 6448.0 6470.7 1032.1 1034.5 1042.2 1053.8 1054.7 5314.9 5341.2 5342.4 5345.4 5381.4 8654.7 8936.2 8940.4 8959.6 9043.0 8943.0 8996.6 9005.1 9007.3 9038.9 6773.8 6897.2 6958.7 6963.4 6970.8 6677.9 6732.2 6736.8 6742.6 6750.2 7903.9 7915.9 7968.3 8086.1 8109.4 8079.0 8213.4 8216.1 8268.2 8342.7 6360.4 6500.6 6525.0 6580.0 6591.4 6998.8 7011.1 7031.2 7042.0 7057.3 6714.2 6734.5 6762.4 6793.0 6820.5 5949.5 6089.8 6135.5 6199.0 6282.9 6150.1 6213.5 6218.5 6228.4 6233.0 5695.8 5719.2 5742.2 5746.6 5754.9 5942.9 6128.3 6134.2 6134.4 6136.3 18:49:07 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | [#4] prototype.html Cycles:180 Average:4671.88 Median:5262.22 stddev:1366.80 (26.0%) stddev-sans-first:1330.67 18:49:07 INFO - PROCESS | 7434 | Values: 300.1 309.7 314.3 320.3 320.8 5284.0 5347.7 5366.4 5419.5 5433.0 5321.1 5326.0 5333.1 5333.5 5342.9 3922.5 4013.6 4200.1 4207.5 4209.6 4038.4 4078.0 4100.5 4104.8 4116.1 4051.7 4057.2 4064.5 4068.5 4073.7 3871.8 3964.1 4021.7 4063.6 4100.1 3594.3 3599.5 3600.6 3613.2 3617.6 5075.1 5085.2 5174.5 5184.8 5188.9 4748.2 4761.3 4764.9 4766.5 4769.2 5488.8 5607.1 5611.1 5621.3 5624.0 4034.1 4034.8 4035.4 4042.0 4042.4 5772.7 5869.3 5872.9 5881.5 5885.9 4108.7 4137.5 4138.0 4139.2 4141.1 4095.3 4191.9 4195.4 4196.9 4217.2 4740.4 4746.9 4758.6 4758.9 4762.5 5592.0 5599.0 5639.8 5640.3 5640.4 1474.6 1502.8 1502.9 1503.7 1505.2 1024.0 1025.4 1029.8 1038.5 1057.6 4939.6 4944.5 4946.9 4950.9 4954.4 5830.3 5835.1 5835.4 5837.9 5840.7 4919.4 4938.2 4945.4 4949.9 4953.8 2902.8 2972.9 3098.0 3104.4 3148.6 5520.7 5526.5 5527.8 5532.6 5541.4 6031.8 6032.2 6034.5 6037.4 6039.9 5519.0 5527.0 5528.0 5538.8 5547.6 5641.4 5887.9 5896.5 5919.7 5925.4 5794.7 5798.2 5800.7 5802.7 5808.7 5527.4 5540.3 5540.9 5553.2 5555.3 3911.2 4003.1 4060.8 4066.0 4066.9 5824.1 5837.7 5838.0 5890.4 5891.5 5622.2 5622.7 5629.9 5633.1 5637.7 5617.6 5622.9 5627.6 5628.7 5634.2 5360.4 5480.6 5505.9 5509.8 5515.3 5616.7 5647.6 5651.9 5652.9 5658.2 5240.4 5337.8 5367.0 5444.9 5483.2 18:49:07 INFO - PROCESS | 7434 | 18:49:07 INFO - PROCESS | 7434 | [#5] yui.html Cycles:180 Average:11400.33 Median:547.80 stddev:12757.08 (2328.8%) stddev-sans-first:12767.52 18:49:07 INFO - PROCESS | 7434 | Values: 691.4 717.1 749.3 762.5 765.2 11259.7 11321.0 11552.5 11563.5 11595.2 10694.7 10735.4 10745.8 10764.2 10765.0 616.7 626.3 626.3 770.7 789.2 625.7 628.7 629.4 778.9 799.6 810.0 814.1 820.6 823.1 823.5 638.5 811.1 813.9 813.9 813.9 478.9 602.8 609.6 615.0 615.6 11476.3 11552.0 11552.9 11554.9 11566.4 10721.6 10999.1 11077.4 11281.0 11372.8 9122.3 9163.7 9253.5 9347.5 9582.1 3180.1 3209.7 3231.8 3238.9 3277.3 34968.5 35180.3 35195.0 35211.0 35290.8 9014.9 9038.2 9039.7 9080.0 9202.1 15165.1 15192.6 15200.8 15211.2 15252.3 6188.0 6223.3 6251.2 6316.7 6334.0 3377.7 3405.1 3421.1 3473.2 3536.9 2459.7 2476.2 2489.2 2489.2 2492.5 442.6 450.3 452.0 454.8 455.8 440.9 552.3 560.5 566.9 586.3 7045.9 7090.6 7132.4 7140.3 7318.7 470.1 515.7 527.8 543.3 559.8 3323.5 3378.7 3508.5 3518.6 3531.7 45324.8 45882.8 45933.3 46080.8 46137.8 41166.0 41477.0 41881.8 44808.6 45683.8 37359.8 38247.7 38263.8 38695.8 38736.6 7450.9 7480.9 7577.5 7683.2 7877.1 28722.0 28763.6 29035.7 29548.4 29695.3 33711.2 34492.5 36603.6 37169.8 37426.8 9460.6 9461.7 9500.0 9522.3 9645.6 10383.3 10441.7 10509.4 10530.0 10683.1 9285.4 9494.5 9593.8 9733.3 9997.4 9351.3 9401.5 9537.1 9540.2 9901.2 9360.2 9372.3 9375.0 9476.1 9593.2 8021.9 8024.5 8143.1 8183.7 8197.7 8260.8 8299.0 8367.0 8675.9 8833.5 18:49:07 INFO - PROCESS | 7434 | -------- Summary: end -------- 18:49:07 INFO - PROCESS | 7434 | 18:49:08 INFO - TEST-INFO | 7434: exit 0 18:49:08 INFO - TEST-OK | dromaeo_css | took 1116385ms 18:49:08 INFO - TEST-START | kraken 18:49:08 INFO - operating with platform_type : linux_ 18:49:08 INFO - Initialising browser for kraken test... 18:49:08 INFO - TEST-INFO | started process 7627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkGoe4/profile http://localhost:46925/getInfo.html) 18:49:12 INFO - PROCESS | 7627 | __metrics Screen width/height:1600/1200 18:49:12 INFO - PROCESS | 7627 | colorDepth:24 18:49:12 INFO - PROCESS | 7627 | Browser inner width/height: 1024/697 18:49:12 INFO - PROCESS | 7627 | __metrics 18:49:12 INFO - PROCESS | 7627 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:49:12 INFO - PROCESS | 7627 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:49:13 INFO - PROCESS | 7627 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 18:49:13 INFO - TEST-INFO | 7627: exit 0 18:49:13 INFO - Browser initialized. 18:49:13 INFO - Running cycle 1/1 for kraken test... 18:49:13 INFO - TEST-INFO | started process 7708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkGoe4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:25 INFO - PROCESS | 7708 | RSS: Main: 147521536 18:49:25 INFO - PROCESS | 7708 | 18:49:28 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46925/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:28 INFO - PROCESS | 7708 | RSS: Main: 184221696 18:49:28 INFO - PROCESS | 7708 | 18:49:31 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46925/tests/kraken/driver.html?testName=audio-dft) 18:49:32 INFO - PROCESS | 7708 | RSS: Main: 172793856 18:49:32 INFO - PROCESS | 7708 | 18:49:35 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46925/tests/kraken/driver.html?testName=audio-fft) 18:49:35 INFO - PROCESS | 7708 | RSS: Main: 158969856 18:49:35 INFO - PROCESS | 7708 | 18:49:37 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46925/tests/kraken/driver.html?testName=audio-oscillator) 18:49:38 INFO - PROCESS | 7708 | RSS: Main: 162127872 18:49:38 INFO - PROCESS | 7708 | 18:49:40 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:41 INFO - PROCESS | 7708 | RSS: Main: 164474880 18:49:41 INFO - PROCESS | 7708 | 18:49:44 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46925/tests/kraken/driver.html?testName=imaging-darkroom) 18:49:44 INFO - PROCESS | 7708 | RSS: Main: 164663296 18:49:44 INFO - PROCESS | 7708 | 18:49:48 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46925/tests/kraken/driver.html?testName=imaging-desaturate) 18:49:48 INFO - PROCESS | 7708 | RSS: Main: 165359616 18:49:48 INFO - PROCESS | 7708 | 18:49:51 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46925/tests/kraken/driver.html?testName=json-parse-financial) 18:49:52 INFO - PROCESS | 7708 | RSS: Main: 164425728 18:49:52 INFO - PROCESS | 7708 | 18:49:54 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:49:54 INFO - PROCESS | 7708 | RSS: Main: 174178304 18:49:54 INFO - PROCESS | 7708 | 18:49:56 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46925/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:49:57 INFO - PROCESS | 7708 | RSS: Main: 172679168 18:49:57 INFO - PROCESS | 7708 | 18:49:59 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:49:59 INFO - PROCESS | 7708 | RSS: Main: 187797504 18:49:59 INFO - PROCESS | 7708 | 18:50:02 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:02 INFO - PROCESS | 7708 | RSS: Main: 190984192 18:50:02 INFO - PROCESS | 7708 | 18:50:05 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:06 INFO - PROCESS | 7708 | RSS: Main: 189165568 18:50:06 INFO - PROCESS | 7708 | 18:50:07 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:46925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46925/tests/kraken/driver.html?testName=ai-astar) 18:50:08 INFO - PROCESS | 7708 | RSS: Main: 247328768 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | __start_tp_report 18:50:08 INFO - PROCESS | 7708 | _x_x_mozilla_page_load 18:50:08 INFO - PROCESS | 7708 | _x_x_mozilla_page_load_details 18:50:08 INFO - PROCESS | 7708 | |i|pagename|runs| 18:50:08 INFO - PROCESS | 7708 | |0;ai-astar;113;116;109;112;114;115;102;113;113;105 18:50:08 INFO - PROCESS | 7708 | |1;audio-beat-detection;160;130;154;177;131;158;152;130;166;140 18:50:08 INFO - PROCESS | 7708 | |2;audio-dft;162;164;160;163;163;161;163;163;164;161 18:50:08 INFO - PROCESS | 7708 | |3;audio-fft;73;72;88;93;71;72;73;123;87;71 18:50:08 INFO - PROCESS | 7708 | |4;audio-oscillator;98;99;137;97;97;98;144;98;98;129 18:50:08 INFO - PROCESS | 7708 | |5;imaging-gaussian-blur;110;109;109;109;109;110;109;110;110;110 18:50:08 INFO - PROCESS | 7708 | |6;imaging-darkroom;146;147;147;147;147;147;146;146;147;146 18:50:08 INFO - PROCESS | 7708 | |7;imaging-desaturate;97;96;96;95;95;98;95;96;95;95 18:50:08 INFO - PROCESS | 7708 | |8;json-parse-financial;70;69;70;68;69;71;70;77;67;69 18:50:08 INFO - PROCESS | 7708 | |9;json-stringify-tinderbox;68;69;69;69;70;69;70;69;69;69 18:50:08 INFO - PROCESS | 7708 | |10;stanford-crypto-aes;87;86;85;85;87;86;86;85;88;86 18:50:08 INFO - PROCESS | 7708 | |11;stanford-crypto-ccm;125;123;123;124;128;134;119;124;126;129 18:50:08 INFO - PROCESS | 7708 | |12;stanford-crypto-pbkdf2;142;144;150;150;152;142;152;148;148;139 18:50:08 INFO - PROCESS | 7708 | |13;stanford-crypto-sha256-iterative;71;71;72;71;72;70;71;73;71;71 18:50:08 INFO - PROCESS | 7708 | __end_tp_report 18:50:08 INFO - PROCESS | 7708 | __start_cc_report 18:50:08 INFO - PROCESS | 7708 | _x_x_mozilla_cycle_collect,1001 18:50:08 INFO - PROCESS | 7708 | __end_cc_report 18:50:08 INFO - PROCESS | 7708 | __startTimestamp1452221408203__endTimestamp 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | ------- Summary: start ------- 18:50:08 INFO - PROCESS | 7708 | Number of tests: 14 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:4.52 (4.0%) stddev-sans-first:4.74 18:50:08 INFO - PROCESS | 7708 | Values: 113.0 116.0 109.0 112.0 114.0 115.0 102.0 113.0 113.0 105.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:156.00 stddev:16.43 (10.5%) stddev-sans-first:17.01 18:50:08 INFO - PROCESS | 7708 | Values: 160.0 130.0 154.0 177.0 131.0 158.0 152.0 130.0 166.0 140.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 18:50:08 INFO - PROCESS | 7708 | Values: 162.0 164.0 160.0 163.0 163.0 161.0 163.0 163.0 164.0 161.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#3] audio-fft Cycles:10 Average:82.30 Median:73.00 stddev:16.55 (22.7%) stddev-sans-first:17.21 18:50:08 INFO - PROCESS | 7708 | Values: 73.0 72.0 88.0 93.0 71.0 72.0 73.0 123.0 87.0 71.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:98.00 stddev:19.09 (19.5%) stddev-sans-first:19.78 18:50:08 INFO - PROCESS | 7708 | Values: 98.0 99.0 137.0 97.0 97.0 98.0 144.0 98.0 98.0 129.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:50:08 INFO - PROCESS | 7708 | Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 18:50:08 INFO - PROCESS | 7708 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:1.00 18:50:08 INFO - PROCESS | 7708 | Values: 97.0 96.0 96.0 95.0 95.0 98.0 95.0 96.0 95.0 95.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:2.71 (3.9%) stddev-sans-first:2.87 18:50:08 INFO - PROCESS | 7708 | Values: 70.0 69.0 70.0 68.0 69.0 71.0 70.0 77.0 67.0 69.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 18:50:08 INFO - PROCESS | 7708 | Values: 68.0 69.0 69.0 69.0 70.0 69.0 70.0 69.0 69.0 69.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 18:50:08 INFO - PROCESS | 7708 | Values: 87.0 86.0 85.0 85.0 87.0 86.0 86.0 85.0 88.0 86.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:125.50 stddev:4.09 (3.3%) stddev-sans-first:4.33 18:50:08 INFO - PROCESS | 7708 | Values: 125.0 123.0 123.0 124.0 128.0 134.0 119.0 124.0 126.0 129.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:149.00 stddev:4.62 (3.1%) stddev-sans-first:4.58 18:50:08 INFO - PROCESS | 7708 | Values: 142.0 144.0 150.0 150.0 152.0 142.0 152.0 148.0 148.0 139.0 18:50:08 INFO - PROCESS | 7708 | 18:50:08 INFO - PROCESS | 7708 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 18:50:08 INFO - PROCESS | 7708 | Values: 71.0 71.0 72.0 71.0 72.0 70.0 71.0 73.0 71.0 71.0 18:50:08 INFO - PROCESS | 7708 | -------- Summary: end -------- 18:50:08 INFO - PROCESS | 7708 | 18:50:09 INFO - TEST-INFO | 7708: exit 0 18:50:09 INFO - TEST-OK | kraken | took 60725ms 18:50:09 INFO - TEST-START | v8_7 18:50:09 INFO - operating with platform_type : linux_ 18:50:09 INFO - Initialising browser for v8_7 test... 18:50:09 INFO - TEST-INFO | started process 7958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWAyEJ/profile http://localhost:46925/getInfo.html) 18:50:13 INFO - PROCESS | 7958 | __metrics Screen width/height:1600/1200 18:50:13 INFO - PROCESS | 7958 | colorDepth:24 18:50:13 INFO - PROCESS | 7958 | Browser inner width/height: 1024/697 18:50:13 INFO - PROCESS | 7958 | __metrics 18:50:13 INFO - PROCESS | 7958 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:50:13 INFO - PROCESS | 7958 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:50:14 INFO - TEST-INFO | 7958: exit 0 18:50:14 INFO - Browser initialized. 18:50:14 INFO - Running cycle 1/1 for v8_7 test... 18:50:14 INFO - TEST-INFO | started process 8038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWAyEJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:26 INFO - PROCESS | 8038 | RSS: Main: 150224896 18:50:26 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | Cycle 1(1): loaded http://localhost:46925/tests/v8_7/run.html (next: http://localhost:46925/tests/v8_7/run.html) 18:50:49 INFO - PROCESS | 8038 | RSS: Main: 447750144 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | __start_tp_report 18:50:49 INFO - PROCESS | 8038 | _x_x_mozilla_page_load 18:50:49 INFO - PROCESS | 8038 | _x_x_mozilla_page_load_details 18:50:49 INFO - PROCESS | 8038 | |i|pagename|runs| 18:50:49 INFO - PROCESS | 8038 | |0;Richards;167.36401673640168 18:50:49 INFO - PROCESS | 8038 | |1;DeltaBlue;189.60940462646948 18:50:49 INFO - PROCESS | 8038 | |2;Encrypt;280.19052956010086 18:50:49 INFO - PROCESS | 8038 | |3;Decrypt;5186.5284974093265 18:50:49 INFO - PROCESS | 8038 | |4;RayTrace;2074.688796680498 18:50:49 INFO - PROCESS | 8038 | |5;Earley;810.3727714748784 18:50:49 INFO - PROCESS | 8038 | |6;Boyer;12195.121951219513 18:50:49 INFO - PROCESS | 8038 | |7;RegExp;44043.47826086957 18:50:49 INFO - PROCESS | 8038 | |8;Splay;600.1195457262403 18:50:49 INFO - PROCESS | 8038 | |9;NavierStokes;4835.748792270531 18:50:49 INFO - PROCESS | 8038 | __end_tp_report 18:50:49 INFO - PROCESS | 8038 | __startTimestamp1452221449295__endTimestamp 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | ------- Summary: start ------- 18:50:49 INFO - PROCESS | 8038 | Number of tests: 10 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 167.4 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#1] DeltaBlue Cycles:1 Average:189.61 Median:189.61 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 189.6 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 280.2 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 5186.5 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#4] RayTrace Cycles:1 Average:2074.69 Median:2074.69 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 2074.7 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#5] Earley Cycles:1 Average:810.37 Median:810.37 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 810.4 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 12195.1 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#7] RegExp Cycles:1 Average:44043.48 Median:44043.48 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 44043.5 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#8] Splay Cycles:1 Average:600.12 Median:600.12 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 600.1 18:50:49 INFO - PROCESS | 8038 | 18:50:49 INFO - PROCESS | 8038 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 18:50:49 INFO - PROCESS | 8038 | Values: 4835.7 18:50:49 INFO - PROCESS | 8038 | -------- Summary: end -------- 18:50:49 INFO - PROCESS | 8038 | 18:50:50 INFO - TEST-INFO | 8038: exit 0 18:50:50 INFO - TEST-OK | v8_7 | took 41066ms 18:50:50 INFO - SUITE-END | took 1218s 18:50:50 INFO - Completed test suite (00:20:18) 18:50:50 INFO - Working with test: dromaeo_css 18:50:50 INFO - Generating results file: dromaeo_css 18:50:50 INFO - Working with test: kraken 18:50:50 INFO - Generating results file: kraken 18:50:50 INFO - javascript benchmark 18:50:50 INFO - Working with test: v8_7 18:50:50 INFO - Generating results file: v8_7 18:50:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:50:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 18:50:50 INFO - process_Request line: dromaeo_css 6084.66 graph.html#tests=[[72,94,35]] 18:50:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:50:50 INFO - process_Request line: kraken 1535.80 graph.html#tests=[[232,94,35]] 18:50:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:50:50 INFO - process_Request line: v8_7 18701.41 graph.html#tests=[[230,94,35]] 18:50:50 INFO - RETURN: dromaeo_css: 6084.66 18:50:50 INFO - RETURN: kraken: 1535.80 18:50:50 INFO - RETURN: v8_7: 18701.41 18:50:50 INFO - javascript benchmark 18:50:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2539.7587229213227, 2635.8682065896714, 2644.3785710358075, 2662.5207462656726, 2664.107523979467, 4245.0660854612015, 4400.7359558426515, 4421.734695918243, 4444.844430444935, 4451.998300382413, 4404.14119246747, 4438.423005009352, 4494.46066472023, 4525.751083690396, 4556.134334476447, 3921.6862650987996, 4012.558618551957, 4177.16456708658, 4185.288500954845, 4316.525182229952, 3918.1184233547365, 4209.915801683965, 4260.573942605745, 4276.786160691969, 4283.571642835707, 4055.0065234017707, 4089.754614723126, 4172.7913604319665, 4187.392828039917, 4220.704550681454, 4109.383592461125, 4109.6506796922295, 4114.19773144237, 4136.896577585584, 4142.378643203544, 3902.2195560887653, 4094.303968325362, 4097.569755175723, 4102.077032667626, 4137.13120244749, 4296.74219546825, 4300.204462174476, 4300.548442413533, 4336.7831608419765, 4350.434443522322, 4650.813967441299, 4679.88300292492, 4789.137955168068, 4795.784189711471, 4829.9275510867365, 4771.33201351811, 4779.259214821708, 4783.856484305442, 4816.783244753994, 4821.85534433964, 4297.39836422901, 4409.625181859577, 4457.48738895028, 4477.955220447819, 4516.051629157881, 4698.600618947427, 4850.563449289511, 4973.079980203674, 4995.275685025651, 4996.07572599063, 4741.502142275081, 4776.8566942991765, 4777.378940737682, 4786.377770889762, 4803.087413391444, 4815.927761083586, 4833.154198015333, 4839.564439200419, 4841.636877234221, 4885.877853053631, 4572.4055872736335, 4659.068186362741, 4705.905881882411, 4729.9054018920115, 4869.342638743795, 4728.290756386569, 4729.6689231754135, 4731.597814185833, 4731.645126615517, 4777.498362671939, 4042.4946881639794, 4043.211573743092, 4044.211378781168, 4045.1707399982934, 4078.3270760324212, 3446.724262059029, 3500.43992961125, 3547.858085676544, 3567.8216089195435, 3599.2441587266444, 4168.416421700964, 4180.414741936132, 4181.540030596632, 4186.539480657125, 4219.029623186623, 4812.51874812523, 4816.397950256218, 4817.710937343771, 4856.344393506902, 4865.9756701216265, 3995.72029957906, 4091.2431200227456, 4094.6314831665295, 4095.406166105898, 4201.7268877522865, 4221.409002739619, 4237.364395340662, 4244.342126970325, 4247.936280955788, 4284.250256205151, 4504.234280172313, 4506.954930450654, 4508.504064552896, 4544.1820472313975, 4555.658325625592, 4584.381108550303, 4725.669203155746, 4730.9763451182525, 4732.929006064843, 4764.166270902509, 4544.886377840448, 4560.977195114003, 4575.3137029444515, 4600.907981840412, 4604.746738929391, 4724.291356296583, 4725.9054818904115, 4729.030548737569, 4743.075100355535, 4772.856814295576, 4534.115847409724, 4661.137689527448, 4663.743494107856, 4800.903981920273, 4807.062622788522, 4643.4892161862845, 4730.668853180245, 4732.834350797705, 4734.289856521412, 4780.211265141352, 4594.012287358234, 4620.745858977789, 4630.120277147466, 4645.790939407667, 4670.906581868411, 4438.134563760165, 4537.636989040935, 4542.409486766699, 4543.613792827647, 4543.840965566189, 4594.081183763194, 4687.203175460112, 4706.717596944194, 4709.034647897104, 4712.575868171881, 4549.727016379028, 4568.451785785594, 4570.977145114253, 4595.540445955377, 4604.286335617984], "unit": "score", "name": "dojo.html", "value": 4389.820541840226}, {"lowerIsBetter": false, "replicates": [484.66800241834324, 515.9251908473271, 519.7297405349218, 521.9973900130499, 529.1533546325879, 24524.87737561314, 24791.0, 25004.999800008, 25027.74972250277, 31985.680143198562, 35012.0, 35659.82170089146, 35686.46470302941, 35700.0, 35715.64284357156, 7499.062617172867, 7687.423443241779, 7721.0, 7721.266479684421, 7724.38204943606, 6800.795976120699, 6989.650517474131, 7672.769816905474, 7878.25156610124, 9475.194608458289, 9511.714648560554, 9540.236781057498, 9635.373700709431, 9643.180329671986, 9643.324967252294, 9272.721818345426, 9396.953015234949, 9424.764380890463, 9428.85856712143, 9429.245660347156, 6806.115205023315, 7005.19440264371, 7016.929830701679, 9491.098345657152, 9782.5597848097, 32866.83566582176, 32951.17622059444, 33206.501902471486, 33484.83257583697, 33487.16282092943, 2776.5002299586067, 2781.8748156333013, 2876.3528206153655, 3289.4407950648447, 3428.9485657715154, 24215.636765448533, 24607.38481537958, 24654.0, 24692.629610555858, 24771.504569908502, 3308.0902751743224, 3340.4822252550894, 3341.5655964724674, 3358.1604598850286, 3422.57217847769, 169063.93892580186, 170404.0, 170673.99999999875, 171073.14463427727, 171110.0, 45641.0, 50125.74937125291, 55022.72488637531, 55086.44913550813, 55190.448095519336, 40520.594794052275, 40758.79620601878, 40902.1819563613, 40920.59079409228, 58421.70789146027, 12435.44040518179, 12545.372731363577, 12613.747725045449, 12710.555130570385, 12747.681307967376, 9610.183134433511, 9611.086946740048, 9680.56437460316, 9716.708498745049, 9723.319367644197, 18095.185716642784, 18308.450746477625, 18332.358367457342, 18353.0, 18361.265549377877, 7360.227176146427, 7863.410244231591, 7890.132085470594, 7935.325497332791, 7990.720324788605, 806.4032615864219, 841.6969890839293, 925.9259259259227, 938.737153596994, 970.5875003123786, 28047.439051218862, 28963.275918101794, 29300.56049159264, 29647.110586682433, 30087.0, 920.4247345409119, 961.8893827209821, 980.8283550378798, 1027.6300531808542, 1040.2510192661273, 13590.320483975762, 13834.654133646538, 14012.299385030708, 14015.089019213718, 14034.368453419416, 327692.0, 332264.0, 333905.0, 334779.0, 335876.12990960665, 45668.314975275396, 45895.082098358514, 45985.540144598126, 46101.07797844092, 46105.0, 1170.0697945133638, 1181.0374544746176, 1183.3964678014274, 1195.7249832538564, 1196.491491116272, 25851.482970340865, 26376.60435093437, 26384.472310553298, 26716.332091697863, 26850.865745671148, 34734.47898281477, 35556.111097222776, 38707.80646096751, 39941.0, 41109.383359249034, 202372.0, 202923.0, 203860.0, 204531.0, 205158.0, 23533.882330588236, 23998.40003999914, 28189.154325370273, 28758.0, 28869.42261154723, 36245.0, 36328.81835590805, 36472.0, 37038.074048149014, 37046.44430333493, 27915.0, 30164.396712066075, 30167.245818854703, 34187.829060854536, 35793.64206357903, 30466.847665762416, 30801.537976930813, 30830.84584577063, 30972.380552388375, 30987.690123099383, 30081.247968800955, 31119.68880311168, 31159.065228043193, 31172.22069448191, 31234.375312493168, 25977.74022259753, 27971.300717482227, 29842.70157298399, 29859.402811944074, 29870.461010813455, 22057.0, 22409.43976400603, 22446.32661020172, 22577.322680319616, 22687.205947791746], "unit": "score", "name": "ext.html", "value": 16131.496925987132}, {"lowerIsBetter": false, "replicates": [330.69080409816826, 331.62570841685846, 332.56434071366505, 333.56469806902, 338.12594443363935, 11946.581869634565, 12350.197237179576, 14542.709145817078, 14880.181590012546, 15454.922725386372, 12337.0, 13573.728525429486, 13589.864101358984, 14057.859421405783, 14088.295585220749, 4726.102040612282, 4900.191468407708, 4913.975430122844, 5997.100434934751, 6288.0, 3980.721349505521, 4133.813978370966, 6141.078838174287, 6249.87500249997, 6308.684565771693, 6190.969045154768, 6364.077208804743, 6396.808095757112, 6402.93597064028, 6418.261899881503, 6353.714082866282, 6392.3927226913365, 6395.3284905084765, 6410.871782564369, 6410.974244120942, 5820.767169313222, 6346.11154438379, 6351.809445716636, 6352.174217351715, 6354.205724284465, 19768.0, 19865.304714335074, 19931.80068199314, 20773.376798696063, 20892.0, 1718.2439726520415, 1749.9212535435809, 1761.2426656537684, 1783.2688597675021, 1938.2247101159649, 12402.19385739924, 12418.689532761662, 12595.3072581008, 12613.558525451657, 13188.802167967488, 1775.9467215983411, 1828.7531183290353, 1865.1047497201284, 1869.803670614593, 1913.5885784556249, 33917.6608233917, 34226.657733422595, 34557.65442345595, 43094.92262693426, 44856.775716121534, 14617.101332577935, 14842.0, 14845.628859278604, 14891.32989015497, 15145.772813407808, 21714.0, 21753.67369489459, 21944.890275548838, 22099.889500552395, 22115.778842211694, 7979.441439099323, 7988.360931125496, 8021.2379823916635, 8047.678092876219, 8078.151794061657, 6262.718177682015, 6321.747130114836, 6331.841703957346, 6348.396902294275, 6465.0, 6494.902576461357, 7242.45681573884, 7356.521826081287, 7401.111866576045, 7545.622718864035, 1727.8876873003214, 1729.0835856995811, 1742.2508321421658, 1745.4763570928671, 2141.8500704950816, 779.1585088104833, 804.7505273365275, 818.6357071103301, 819.5082950229814, 906.5603182456504, 12440.937795310965, 13971.301434928213, 14329.426822927175, 14366.281685915663, 15101.622459438602, 845.8519759042143, 861.3324673378057, 864.6282098697494, 902.4404868981143, 929.4237572704831, 8334.958325208336, 8601.5699215039, 8611.138886111465, 8720.084391138966, 8988.370814042953, 300306.0, 305487.0, 309463.0, 310584.0, 439670.0, 54256.0, 66562.66718666376, 67003.3299666997, 67093.0, 68087.65956170188, 1007.4358359318659, 1012.2964539644876, 1023.9827539746835, 1051.6476980211562, 1054.4938429553704, 12890.16213946128, 13210.867891320964, 13567.59297221085, 13898.37457314403, 13911.234882081582, 27098.32254193582, 28064.158075257776, 28304.575431368135, 28402.43195136127, 28773.424531508834, 31401.0, 37332.81333593423, 37441.0, 37660.43509347307, 41176.794116029225, 6283.748650053946, 6629.966850165718, 6693.464522838064, 6725.293844146294, 6849.48628852848, 3003.05403797803, 4033.910844072143, 4946.703197808143, 9683.709488715349, 10048.648297309559, 8551.871721924052, 8696.913030869864, 8957.14907083826, 9079.046700096394, 9159.084091590788, 6134.447899689049, 8482.448640838325, 9034.909650903406, 9157.725268241964, 9460.95269523648, 8234.300084492885, 8281.012556986401, 8825.20573148394, 8930.955345223232, 8947.552622368985, 6246.781362652286, 6484.967575162094, 6509.804705858832, 6540.803775886731, 6580.234345369967, 7773.883391749241, 9032.954835225783, 9078.773030674021, 9094.954525227331, 9122.221166872661], "unit": "score", "name": "jquery.html", "value": 7812.751308129327}, {"lowerIsBetter": false, "replicates": [1208.9818652720205, 1329.142702956593, 1340.9798853017207, 1428.8571142885712, 1692.840404323039, 6031.035034394497, 7101.0, 7178.9282107178915, 7186.245444228359, 7187.065681461409, 6870.759523416681, 7004.439644828414, 7037.577745335284, 7063.85872282554, 7081.327273908983, 1710.1021963469154, 1739.2173521915126, 2010.0753653319491, 2014.5870096630156, 2037.602667479842, 1892.3944337811906, 1894.6684330242222, 1906.2756152661968, 1906.5138389710605, 1907.3419670213755, 1962.8233458988689, 1998.1407994562333, 2025.9392218233477, 2029.1376165129761, 2029.3607513633233, 2011.9094640741203, 2017.122551690005, 2033.9898300508478, 2040.6428874946898, 2042.3668662714606, 1993.9800601994084, 2006.8595198336122, 2011.0447537419755, 2013.577148798754, 2016.991504247876, 6943.47923905704, 6974.128233970754, 6978.895316570255, 6984.476164287698, 6995.685194166274, 3895.0, 3980.2835489611857, 3986.0034991252187, 4004.0790618157985, 4008.4388185654034, 2477.95044099117, 2562.4490734492174, 2593.766561009499, 2617.5942728877053, 2618.7250338714543, 790.9011373578303, 794.7695168401157, 815.229608020421, 821.5645707774889, 822.3914303415429, 8757.824843503095, 8765.211130998241, 8798.428102173402, 8807.559622018938, 8812.603432845537, 3605.3690604144695, 3678.0, 3725.720570957189, 3727.5713292971113, 3728.813559322023, 7765.883511747328, 7773.844523109507, 7781.06627204739, 7789.805254868674, 7791.142974272825, 4092.7953602319767, 4093.6520395766693, 4097.242010228118, 4097.8975525612095, 4110.897227569335, 3791.9810400947817, 3794.8482060717815, 3797.316483033025, 3802.239552089593, 3805.980970095132, 2971.182924695726, 3072.047665223743, 3074.6771588983283, 3443.9655603444144, 3553.7157027437743, 935.476133365304, 942.0, 1058.7935352606169, 1076.494047797534, 1079.2930630437077, 1145.9140564457698, 1174.5830230268132, 1176.717587778944, 1181.1790805390342, 1204.59646018583, 6223.937760622426, 6279.654618995908, 6320.8419789504715, 6448.0, 6470.676466176672, 1032.0814475117152, 1034.5499707627055, 1042.2287507244585, 1053.8208504554243, 1054.7099547624464, 5314.867128321823, 5341.172118321666, 5342.385625653022, 5345.3852806926925, 5381.3811411687375, 8654.740357789276, 8936.239928112831, 8940.41887277338, 8959.5968181432, 9043.0, 8943.016268210491, 8996.59515321799, 9005.054469280762, 9007.324450666227, 9038.86441703375, 6773.830654233683, 6897.241303456616, 6958.686859091353, 6963.373296403348, 6970.79087627372, 6677.866442671022, 6732.192136943598, 6736.7642132525125, 6742.629155396304, 6750.1562304711915, 7903.9209607903185, 7915.881261780963, 7968.282854543119, 8086.11052784205, 8109.351251899951, 8078.959605201936, 8213.425060245965, 8216.055153657406, 8268.214519620626, 8342.666293348198, 6360.363963603602, 6500.642464664489, 6524.967375163284, 6580.045893345342, 6591.439727623206, 6998.825029374103, 7011.053507776385, 7031.226565077735, 7042.0, 7057.294270572902, 6714.2278637955305, 6734.528582999143, 6762.391384775394, 6792.966035169792, 6820.488463365168, 5949.464548190684, 6089.847753806191, 6135.509159267337, 6199.0, 6282.937170628235, 6150.138980542638, 6213.5339849510565, 6218.471429928507, 6228.377162283917, 6232.968835155795, 5695.772169113189, 5719.199312096393, 5742.16738572913, 5746.597738158456, 5754.856128596651, 5942.940570594239, 6128.264608247039, 6134.171886795404, 6134.38656134383, 6136.325004249618], "unit": "score", "name": "mootools.html", "value": 4032.819521563454}, {"lowerIsBetter": false, "replicates": [300.05183619761556, 309.6980444067035, 314.33047608593705, 320.31612507296927, 320.7594304271796, 5284.0, 5347.652402593833, 5366.409694933554, 5419.512243898049, 5433.0, 5321.148616221405, 5325.973370133144, 5333.093374126398, 5333.493318134781, 5342.946570534294, 3922.4900762900784, 4013.5585085640555, 4200.1179752252065, 4207.45303110596, 4209.6000879916355, 4038.3538633818594, 4078.0, 4100.528439229497, 4104.753714777123, 4116.073883376246, 4051.6556092732153, 4057.229126465962, 4064.471618689581, 4068.4914385701786, 4073.6944729145434, 3871.8064096795047, 3964.108075682977, 4021.698372622065, 4063.5936406359424, 4100.138970816132, 3594.3350480160993, 3599.4600809878466, 3600.567931848169, 3613.150909536283, 3617.602063772983, 5075.061113693979, 5085.160948443502, 5174.482551744795, 5184.792608295701, 5188.870278243036, 4748.216544270192, 4761.262004389325, 4764.928526072112, 4766.547178018118, 4769.213079841857, 5488.835334939959, 5607.130894711327, 5611.0741727614895, 5621.269234999424, 5623.971880140573, 4034.0519977805193, 4034.838606455738, 4035.3745169498775, 4041.959580404188, 4042.43405923171, 5772.740226689809, 5869.266341707286, 5872.853178670524, 5881.47066763989, 5885.85285367865, 4108.650764685035, 4137.462129923151, 4138.02756352257, 4139.2135494256, 4141.109661422748, 4095.3242714952294, 4191.8742437726305, 4195.412642230091, 4196.874093777192, 4217.198732240864, 4740.407449068866, 4746.928796068062, 4758.595519380822, 4758.857234282977, 4762.523747625279, 5592.0, 5598.972005139948, 5639.802606908738, 5640.32316122068, 5640.407757185519, 1474.6387135151956, 1502.8046353974132, 1502.8647421732096, 1503.7293287208188, 1505.1947208243755, 1023.9846402303972, 1025.4206373399006, 1029.7785976015043, 1038.4859494550094, 1057.6404022632341, 4939.580135688435, 4944.456109827916, 4946.9010619787405, 4950.9009819803405, 4954.355933728592, 5830.329512106162, 5835.066389377679, 5835.416458354131, 5837.883242335214, 5840.707964601838, 4919.409670839451, 4938.234573641092, 4945.381827271591, 4949.90100197994, 4953.801847926043, 2902.796804223684, 2972.8513574321196, 3098.0396077216137, 3104.379124175174, 3148.5592017117624, 5520.723963801875, 5526.50261476469, 5527.778888844482, 5532.640378375393, 5541.390447050821, 6031.849203769941, 6032.1856549365275, 6034.5172386209, 6037.366076561985, 6039.8792024159275, 5518.972405137949, 5526.972365138229, 5528.032594295983, 5538.8061417851795, 5547.639403438763, 5641.435856414326, 5887.941120588739, 5896.469317761422, 5919.733611987557, 5925.377835327228, 5794.681292528951, 5798.15926690619, 5800.738966746591, 5802.709864506842, 5808.7095645218415, 5527.39198688152, 5540.307461567304, 5540.944590554042, 5553.194786755978, 5555.30558680165, 3911.159100793343, 4003.099302656879, 4060.7766572837595, 4066.0, 4066.8983275417168, 5824.126381042877, 5837.737301821513, 5837.970810145922, 5890.440408161217, 5891.49922256613, 5622.1566764983945, 5622.662640241599, 5629.887402252014, 5633.0987042073075, 5637.689927054052, 5617.578681598815, 5622.943770562406, 5627.606067575231, 5628.746706398304, 5634.183043458757, 5360.43715409892, 5480.6437581557075, 5505.9174112387545, 5509.752061157177, 5515.338159420735, 5616.747246373841, 5647.632903861236, 5651.915221271602, 5652.886942261214, 5658.207850900795, 5240.449752775904, 5337.786488540571, 5367.033933891937, 5444.891102178013, 5483.177523371526], "unit": "score", "name": "prototype.html", "value": 4239.766410626465}, {"lowerIsBetter": false, "replicates": [691.4261163234515, 717.0821348673696, 749.2619769527016, 762.4815125714515, 765.1697907770069, 11259.718507037329, 11321.0, 11552.480138393772, 11563.53745850167, 11595.188336816416, 10694.679159625204, 10735.355878647268, 10745.83881241782, 10764.24650274481, 10765.03114719675, 616.6515918506052, 626.2797782550081, 626.3423405424286, 770.734096736625, 789.1634867040955, 625.6934102289867, 628.6699482771536, 629.4429429954478, 778.9104253010892, 799.5842162075717, 809.9595020248964, 814.0882211922655, 820.6184124382161, 823.0987069159261, 823.5388182617753, 638.5179189711738, 811.0510702478115, 813.8860559521672, 813.894193754814, 813.9470934389306, 478.8898553332753, 602.7528713227556, 609.6068036116679, 614.9538784591128, 615.6060121522229, 11476.254043487146, 11552.0, 11552.884471155348, 11554.942225288904, 11566.42167891602, 10721.624743133953, 10999.065079468255, 11077.446127693584, 11280.969952556628, 11372.829407558893, 9122.315826312986, 9163.679271225541, 9253.491057991874, 9347.485888276142, 9582.13760761528, 3180.061881744891, 3209.6629853865243, 3231.8222497762613, 3238.91902702432, 3277.2626159114247, 34968.475472867925, 35180.29639407198, 35195.0, 35211.0, 35290.82354588211, 9014.86477702835, 9038.231750301167, 9039.728808135766, 9080.0, 9202.125798049176, 15165.09009459436, 15192.620184495256, 15200.771988420183, 15211.239438028055, 15252.313645885963, 6188.009918413032, 6223.253209614875, 6251.249850018027, 6316.684165791692, 6334.0, 3377.67912048355, 3405.063607507955, 3421.0763093964492, 3473.218525831718, 3536.91157721059, 2459.6679448274613, 2476.1581062438495, 2489.178571071542, 2489.191012920808, 2492.501499700067, 442.5773386415965, 450.27280941280253, 451.9796609152596, 454.80443409334305, 455.81311662218997, 440.8919814645432, 552.259971638007, 560.4647561578764, 566.8582854286428, 586.2993722501569, 7045.89431158533, 7090.610016449042, 7132.393746531499, 7140.321669441395, 7318.707251709872, 470.0622258594058, 515.6957395136812, 527.8231792349605, 543.3371287029818, 559.7900787204799, 3323.516198272869, 3378.6621337866018, 3508.5438892944267, 3518.648135186461, 3531.6644918732677, 45324.77337613291, 45882.77058614686, 45933.31100033502, 46080.76959615247, 46137.7693111539, 41166.0, 41477.0, 41881.79059104685, 44808.55191448109, 45683.77158114188, 37359.81320093382, 38247.661331853255, 38263.80868095697, 38695.80652096721, 38736.6126338733, 7450.8882366763455, 7480.887786683313, 7577.5453472791805, 7683.231676832272, 7877.094134174643, 28722.0, 28763.5685464714, 29035.7096429033, 29548.409031818814, 29695.25761855971, 33711.15722106967, 34492.48261276033, 36603.633963660024, 37169.81415092907, 37426.8128659355, 9460.574274157541, 9461.716148515556, 9500.0, 9522.285828562746, 9645.565949532147, 10383.325083869524, 10441.738956526147, 10509.36943783345, 10530.0, 10683.091937185116, 9285.350025498421, 9494.525273736148, 9593.808123837345, 9733.318667693193, 9997.350172238781, 9351.298652600946, 9401.52992350366, 9537.14165725088, 9540.189083927944, 9901.207903367856, 9360.20438262728, 9372.250219982248, 9375.0, 9476.14714675655, 9593.184579310837, 8021.919780802117, 8024.482146773317, 8143.104258531675, 8183.71357002502, 8197.672093116447, 8260.83478330442, 8298.958505207434, 8367.0, 8675.91324086751, 8833.469991800512], "unit": "score", "name": "yui.html", "value": 5364.110595217362}], "name": "dromaeo_css", "value": 6084.660574710122}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 116.0, 109.0, 112.0, 114.0, 115.0, 102.0, 113.0, 113.0, 105.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [160.0, 130.0, 154.0, 177.0, 131.0, 158.0, 152.0, 130.0, 166.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 160.0, 163.0, 163.0, 161.0, 163.0, 163.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 88.0, 93.0, 71.0, 72.0, 73.0, 123.0, 87.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 137.0, 97.0, 97.0, 98.0, 144.0, 98.0, 98.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 95.0, 95.0, 98.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 68.0, 69.0, 71.0, 70.0, 77.0, 67.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 85.0, 85.0, 87.0, 86.0, 86.0, 85.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [125.0, 123.0, 123.0, 124.0, 128.0, 134.0, 119.0, 124.0, 126.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [142.0, 144.0, 150.0, 150.0, 152.0, 142.0, 152.0, 148.0, 148.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 71.0, 72.0, 70.0, 71.0, 73.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1535.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [189.60940462646948], "unit": "score", "name": "DeltaBlue", "value": 348.7063319999999}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [2074.688796680498], "unit": "score", "name": "RayTrace", "value": 356.67469799999986}, {"lowerIsBetter": false, "replicates": [810.3727714748784], "unit": "score", "name": "Earley", "value": 822.4153420000002}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [44043.47826086957], "unit": "score", "name": "RegExp", "value": 20.683766041460988}, {"lowerIsBetter": false, "replicates": [600.1195457262403], "unit": "score", "name": "Splay", "value": 135.79127788844616}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18701.41208313184}]} 18:50:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "18701.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1535.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6084.66"}}} 18:50:50 INFO - Return code: 0 18:50:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:50:50 INFO - # TBPL SUCCESS # 18:50:50 INFO - Running post-action listener: _resource_record_post_action 18:50:50 INFO - Running post-run listener: _resource_record_post_run 18:50:51 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 551194624; Read time: 0; Write time: 490552 18:50:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231829504; Read time: 0; Write time: 250240 18:50:51 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 319365120; Read time: 0; Write time: 240312 18:50:51 INFO - Running post-run listener: _upload_blobber_files 18:50:51 INFO - Blob upload gear active. 18:50:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:51 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 18:50:51 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:50:51 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:50:52 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:50:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:53 INFO - (blobuploader) - INFO - Done attempting. 18:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:53 INFO - (blobuploader) - INFO - Done attempting. 18:50:53 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:53 INFO - Return code: 0 18:50:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6f5f9a3ba98cd33441315d47112b812695df9a795eb0ea9bd645728fe2e4bc67b2be9057dc5c898983e6d251741dd5d413b62fa7f55aad1c794d1a4863b8869", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4059b00eacbba5debf61b0afe6f26df2ee976a8198e707c9adc9a78fe3317f615003b214bd529434926ce8b216c105defb10dcd3dbbff342b1ed3e2a6a3b8c3"} 18:50:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:53 INFO - Contents: 18:50:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6f5f9a3ba98cd33441315d47112b812695df9a795eb0ea9bd645728fe2e4bc67b2be9057dc5c898983e6d251741dd5d413b62fa7f55aad1c794d1a4863b8869", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4059b00eacbba5debf61b0afe6f26df2ee976a8198e707c9adc9a78fe3317f615003b214bd529434926ce8b216c105defb10dcd3dbbff342b1ed3e2a6a3b8c3"} 18:50:53 INFO - Copying logs to upload dir... 18:50:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.695927 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-07 18:50:53.151972) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 18:50:53.155435) ========= 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=32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6f5f9a3ba98cd33441315d47112b812695df9a795eb0ea9bd645728fe2e4bc67b2be9057dc5c898983e6d251741dd5d413b62fa7f55aad1c794d1a4863b8869", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4059b00eacbba5debf61b0afe6f26df2ee976a8198e707c9adc9a78fe3317f615003b214bd529434926ce8b216c105defb10dcd3dbbff342b1ed3e2a6a3b8c3"} build_url:https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/AfnQ5DFfSp6zmsoAA6sjVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6f5f9a3ba98cd33441315d47112b812695df9a795eb0ea9bd645728fe2e4bc67b2be9057dc5c898983e6d251741dd5d413b62fa7f55aad1c794d1a4863b8869", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4059b00eacbba5debf61b0afe6f26df2ee976a8198e707c9adc9a78fe3317f615003b214bd529434926ce8b216c105defb10dcd3dbbff342b1ed3e2a6a3b8c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 18:50:53.180201) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 18:50:53.180520) ========= 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=32c5991c409366f7fec8a718000001d2-1452219977.125266-327398496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 18:50:53.265833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 18:50:53.266149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 18:50:53.266436) ========= ========= Total master_lag: 0.23 =========