builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1452817780.83 results: success (0) buildid: 20160114154357 builduid: 4c0dea16939242c289e2678e35179200 revision: 0d39fb92a77487fe494da2b3721815aa50cec625 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.830878) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.831316) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.831614) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006265 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.854060) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.854327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.867761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.868022) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.917106) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.917396) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.917763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:40.918031) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 16:29:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.6M=0s 2016-01-14 16:29:41 (29.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093573 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.023562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.023868) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022644 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.073338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.073687) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d39fb92a77487fe494da2b3721815aa50cec625 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0d39fb92a77487fe494da2b3721815aa50cec625 --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=516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 16:29:41,744 truncating revision to first 12 chars 2016-01-14 16:29:41,744 Setting DEBUG logging. 2016-01-14 16:29:41,744 attempt 1/10 2016-01-14 16:29:41,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d39fb92a774?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 16:29:41,998 unpacking tar archive at: fx-team-0d39fb92a774/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533321 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.620235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.620607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.627675) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.627960) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 16:29:41.628369) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-14 16:29:41.628671) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:29:42 INFO - MultiFileLogger online at 20160114 16:29:42 in /builds/slave/test 16:29:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:29:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:29:42 INFO - {'append_to_log': False, 16:29:42 INFO - 'base_work_dir': '/builds/slave/test', 16:29:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:29:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:29:42 INFO - 'branch': 'Fx-Team-Non-PGO', 16:29:42 INFO - 'buildbot_json_path': 'buildprops.json', 16:29:42 INFO - 'config_files': ('talos/linux_config.py',), 16:29:42 INFO - 'default_actions': ('clobber', 16:29:42 INFO - 'read-buildbot-config', 16:29:42 INFO - 'download-and-extract', 16:29:42 INFO - 'populate-webroot', 16:29:42 INFO - 'create-virtualenv', 16:29:42 INFO - 'install', 16:29:42 INFO - 'run-tests'), 16:29:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:29:42 INFO - 'download_minidump_stackwalk': True, 16:29:42 INFO - 'download_symbols': 'ondemand', 16:29:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:29:42 INFO - 'tooltool.py': '/tools/tooltool.py', 16:29:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:29:42 INFO - '/tools/misc-python/virtualenv.py')}, 16:29:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:29:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:29:42 INFO - 'installer_path': 'installer.exe', 16:29:42 INFO - 'log_level': 'info', 16:29:42 INFO - 'log_name': 'talos', 16:29:42 INFO - 'log_to_console': True, 16:29:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:29:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:29:42 INFO - 'opt_config_files': (), 16:29:42 INFO - 'pip_index': False, 16:29:42 INFO - 'sps_profile': False, 16:29:42 INFO - 'sps_profile_interval': 0, 16:29:42 INFO - 'suite': 'dromaeojs', 16:29:42 INFO - 'system_bits': '32', 16:29:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:29:42 INFO - 'title': 'talos-linux64-ix-061', 16:29:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:29:42 INFO - 'use_talos_json': True, 16:29:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:29:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:29:42 INFO - 'work_dir': 'build'} 16:29:42 INFO - ##### 16:29:42 INFO - ##### Running clobber step. 16:29:42 INFO - ##### 16:29:42 INFO - Running pre-action listener: _resource_record_pre_action 16:29:42 INFO - Running main action method: clobber 16:29:42 INFO - rmtree: /builds/slave/test/build 16:29:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:29:43 INFO - Running post-action listener: _resource_record_post_action 16:29:43 INFO - ##### 16:29:43 INFO - ##### Running read-buildbot-config step. 16:29:43 INFO - ##### 16:29:43 INFO - Running pre-action listener: _resource_record_pre_action 16:29:43 INFO - Running main action method: read_buildbot_config 16:29:43 INFO - Using buildbot properties: 16:29:43 INFO - { 16:29:43 INFO - "project": "", 16:29:43 INFO - "product": "firefox", 16:29:43 INFO - "script_repo_revision": "production", 16:29:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:29:43 INFO - "repository": "", 16:29:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:29:43 INFO - "buildid": "20160114154357", 16:29:43 INFO - "pgo_build": "False", 16:29:43 INFO - "basedir": "/builds/slave/test", 16:29:43 INFO - "buildnumber": 1238, 16:29:43 INFO - "slavename": "talos-linux64-ix-061", 16:29:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:29:43 INFO - "platform": "ubuntu64_hw", 16:29:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:29:43 INFO - "branch": "fx-team", 16:29:43 INFO - "repo_path": "integration/fx-team", 16:29:43 INFO - "revision": "0d39fb92a77487fe494da2b3721815aa50cec625", 16:29:43 INFO - "stage_platform": "linux64", 16:29:43 INFO - "builduid": "4c0dea16939242c289e2678e35179200", 16:29:43 INFO - "slavebuilddir": "test" 16:29:43 INFO - } 16:29:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:29:43 INFO - Running post-action listener: _resource_record_post_action 16:29:43 INFO - ##### 16:29:43 INFO - ##### Running download-and-extract step. 16:29:43 INFO - ##### 16:29:43 INFO - Running pre-action listener: _resource_record_pre_action 16:29:43 INFO - Running main action method: download_and_extract 16:29:43 INFO - mkdir: /builds/slave/test/build/tests 16:29:43 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')]} 16:29:43 INFO - https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:29:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/test_packages.json 16:29:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/test_packages.json 16:29:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:29:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:29:44 INFO - Downloaded 1448 bytes. 16:29:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:29:44 INFO - Using the following test package requirements: 16:29:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:29:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:29:44 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:29:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:44 INFO - u'jsshell-linux-x86_64.zip'], 16:29:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:29:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:29:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:29:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:29:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:29:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:29:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:29:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:29:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:29:44 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')]} 16:29:44 INFO - https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:29:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:29:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:29:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/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 16:29:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/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 16:29:46 INFO - Downloaded 21171007 bytes. 16:29:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:29:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:29:47 INFO - Return code: 0 16:29:47 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 16:29:47 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')]} 16:29:47 INFO - https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:29:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:29:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:29:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/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 16:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/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 16:29:50 INFO - Downloaded 21171007 bytes. 16:29:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:29:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:29:51 INFO - Return code: 0 16:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:51 INFO - https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:29:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:29:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:29:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/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 16:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/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 16:29:53 INFO - Downloaded 11132144 bytes. 16:29:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:29:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:29:53 INFO - Return code: 0 16:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:53 INFO - https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:29:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:29:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:29:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/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 16:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STjj6zDhTbiHpw15XNcezA/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 16:29:57 INFO - Downloaded 54213255 bytes. 16:29:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:29:57 INFO - mkdir: /builds/slave/test/properties 16:29:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:29:57 INFO - Writing to file /builds/slave/test/properties/build_url 16:29:57 INFO - Contents: 16:29:57 INFO - build_url:https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:29:57 INFO - Running post-action listener: _resource_record_post_action 16:29:57 INFO - Running post-action listener: set_extra_try_arguments 16:29:57 INFO - ##### 16:29:57 INFO - ##### Running populate-webroot step. 16:29:57 INFO - ##### 16:29:57 INFO - Running pre-action listener: _resource_record_pre_action 16:29:57 INFO - Running main action method: populate_webroot 16:29:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:29:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:29:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:29:57 INFO - '--tppagecycles', 16:29:57 INFO - '7'], 16:29:57 INFO - 'tests': ['tsvgm']}}, 16:29:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:29:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:29:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:29:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:29:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:57 INFO - 'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:57 INFO - 'tests': ['damp', 'tps']}, 16:29:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:57 INFO - 'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['damp', 'tps']}, 16:29:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:29:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:29:57 INFO - 'other': {'tests': ['a11yr', 16:29:57 INFO - 'ts_paint', 16:29:57 INFO - 'tpaint', 16:29:57 INFO - 'sessionrestore', 16:29:57 INFO - 'sessionrestore_no_auto_restore']}, 16:29:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['a11yr', 16:29:57 INFO - 'ts_paint', 16:29:57 INFO - 'tpaint', 16:29:57 INFO - 'sessionrestore', 16:29:57 INFO - 'sessionrestore_no_auto_restore']}, 16:29:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['a11yr', 16:29:57 INFO - 'ts_paint', 16:29:57 INFO - 'tpaint', 16:29:57 INFO - 'sessionrestore', 16:29:57 INFO - 'sessionrestore_no_auto_restore']}, 16:29:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['a11yr', 16:29:57 INFO - 'ts_paint', 16:29:57 INFO - 'tpaint', 16:29:57 INFO - 'sessionrestore', 16:29:57 INFO - 'sessionrestore_no_auto_restore']}, 16:29:57 INFO - 'other_l64': {'tests': ['a11yr', 16:29:57 INFO - 'ts_paint', 16:29:57 INFO - 'tpaint', 16:29:57 INFO - 'sessionrestore', 16:29:57 INFO - 'sessionrestore_no_auto_restore']}, 16:29:57 INFO - 'other_nol64': {'tests': ['a11yr', 16:29:57 INFO - 'ts_paint', 16:29:57 INFO - 'tpaint', 16:29:57 INFO - 'sessionrestore', 16:29:57 INFO - 'sessionrestore_no_auto_restore']}, 16:29:57 INFO - 'svgr': {'tests': ['tsvgx', 16:29:57 INFO - 'tsvgr_opacity', 16:29:57 INFO - 'tart', 16:29:57 INFO - 'tscrollx', 16:29:57 INFO - 'cart']}, 16:29:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['tsvgx', 16:29:57 INFO - 'tsvgr_opacity', 16:29:57 INFO - 'tart', 16:29:57 INFO - 'tscrollx', 16:29:57 INFO - 'cart']}, 16:29:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:57 INFO - 'tests': ['tp5o']}, 16:29:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:57 INFO - 'talos_options': ['--e10s'], 16:29:57 INFO - 'tests': ['tp5o']}, 16:29:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:57 INFO - 'talos_options': ['--xperf_path', 16:29:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:57 INFO - 'tests': ['tp5n']}, 16:29:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:57 INFO - 'talos_options': ['--e10s', 16:29:57 INFO - '--xperf_path', 16:29:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:57 INFO - 'tests': ['tp5n']}}, 16:29:57 INFO - 'talos.zip': {'path': '', 16:29:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:29:57 INFO - Running post-action listener: _resource_record_post_action 16:29:57 INFO - ##### 16:29:57 INFO - ##### Running create-virtualenv step. 16:29:57 INFO - ##### 16:29:57 INFO - Running pre-action listener: _resource_record_pre_action 16:29:57 INFO - Running main action method: create_virtualenv 16:29:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:29:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:29:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:29:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:29:57 INFO - Using real prefix '/usr' 16:29:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:29:58 INFO - Installing distribute.............................................................................................................................................................................................done. 16:29:59 INFO - Installing pip.................done. 16:29:59 INFO - Return code: 0 16:29:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16: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', 'pip>=1.5'] in /builds/slave/test/build 16: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 pip>=1.5 16:29:59 INFO - Using env: {'DISPLAY': ':0', 16:29:59 INFO - 'HOME': '/home/cltbld', 16:29:59 INFO - 'LANG': 'en_US.UTF-8', 16:29:59 INFO - 'LANGUAGE': 'en_US:en', 16:29:59 INFO - 'LOGNAME': 'cltbld', 16:29:59 INFO - 'MAIL': '/var/mail/cltbld', 16:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:59 INFO - 'MOZ_NO_REMOTE': '1', 16:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:59 INFO - 'NO_EM_RESTART': '1', 16:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:59 INFO - 'PWD': '/builds/slave/test', 16:29:59 INFO - 'SHELL': '/bin/bash', 16:29:59 INFO - 'SHLVL': '1', 16:29:59 INFO - 'TERM': 'linux', 16:29:59 INFO - 'TMOUT': '86400', 16:29:59 INFO - 'USER': 'cltbld', 16:29:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:59 INFO - '_': '/tools/buildbot/bin/python'} 16:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:00 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 16:30:00 INFO - Cleaning up... 16:30:00 INFO - Return code: 0 16:30:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:30:00 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')]} 16:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:00 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')]} 16:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:00 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 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16:30:00 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 16:30:00 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 16:30:00 INFO - Using env: {'DISPLAY': ':0', 16:30:00 INFO - 'HOME': '/home/cltbld', 16:30:00 INFO - 'LANG': 'en_US.UTF-8', 16:30:00 INFO - 'LANGUAGE': 'en_US:en', 16:30:00 INFO - 'LOGNAME': 'cltbld', 16:30:00 INFO - 'MAIL': '/var/mail/cltbld', 16:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:00 INFO - 'MOZ_NO_REMOTE': '1', 16:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:00 INFO - 'NO_EM_RESTART': '1', 16:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:00 INFO - 'PWD': '/builds/slave/test', 16:30:00 INFO - 'SHELL': '/bin/bash', 16:30:00 INFO - 'SHLVL': '1', 16:30:00 INFO - 'TERM': 'linux', 16:30:00 INFO - 'TMOUT': '86400', 16:30:00 INFO - 'USER': 'cltbld', 16:30:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:00 INFO - '_': '/tools/buildbot/bin/python'} 16:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:00 INFO - Downloading/unpacking psutil>=0.7.1 16:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:30:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:30:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:02 INFO - Installing collected packages: psutil 16:30:02 INFO - Running setup.py install for psutil 16:30:02 INFO - building 'psutil._psutil_linux' extension 16:30:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:30:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:30:02 INFO - building 'psutil._psutil_posix' extension 16:30:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:30:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:30:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:02 INFO - Successfully installed psutil 16:30:02 INFO - Cleaning up... 16:30:02 INFO - Return code: 0 16:30:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:30:03 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 16:30:03 INFO - Using env: {'DISPLAY': ':0', 16:30:03 INFO - 'HOME': '/home/cltbld', 16:30:03 INFO - 'LANG': 'en_US.UTF-8', 16:30:03 INFO - 'LANGUAGE': 'en_US:en', 16:30:03 INFO - 'LOGNAME': 'cltbld', 16:30:03 INFO - 'MAIL': '/var/mail/cltbld', 16:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:03 INFO - 'MOZ_NO_REMOTE': '1', 16:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:03 INFO - 'NO_EM_RESTART': '1', 16:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:03 INFO - 'PWD': '/builds/slave/test', 16:30:03 INFO - 'SHELL': '/bin/bash', 16:30:03 INFO - 'SHLVL': '1', 16:30:03 INFO - 'TERM': 'linux', 16:30:03 INFO - 'TMOUT': '86400', 16:30:03 INFO - 'USER': 'cltbld', 16:30:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:03 INFO - '_': '/tools/buildbot/bin/python'} 16:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:30:03 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 16:30:03 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 16:30:03 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 16:30:03 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 16:30:03 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 16:30:03 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 16:30:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:30:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:30:04 INFO - Installing collected packages: mozsystemmonitor 16:30:04 INFO - Running setup.py install for mozsystemmonitor 16:30:05 INFO - Successfully installed mozsystemmonitor 16:30:05 INFO - Cleaning up... 16:30:05 INFO - Return code: 0 16:30:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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', '--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 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16:30:05 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 16:30:05 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 16:30:05 INFO - Using env: {'DISPLAY': ':0', 16:30:05 INFO - 'HOME': '/home/cltbld', 16:30:05 INFO - 'LANG': 'en_US.UTF-8', 16:30:05 INFO - 'LANGUAGE': 'en_US:en', 16:30:05 INFO - 'LOGNAME': 'cltbld', 16:30:05 INFO - 'MAIL': '/var/mail/cltbld', 16:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:05 INFO - 'MOZ_NO_REMOTE': '1', 16:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:05 INFO - 'NO_EM_RESTART': '1', 16:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:05 INFO - 'PWD': '/builds/slave/test', 16:30:05 INFO - 'SHELL': '/bin/bash', 16:30:05 INFO - 'SHLVL': '1', 16:30:05 INFO - 'TERM': 'linux', 16:30:05 INFO - 'TMOUT': '86400', 16:30:05 INFO - 'USER': 'cltbld', 16:30:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:05 INFO - '_': '/tools/buildbot/bin/python'} 16:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:05 INFO - Downloading/unpacking blobuploader==1.2.4 16:30:05 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 16:30:05 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 16:30:05 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 16:30:05 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 16:30:05 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 16:30:05 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 16:30:07 INFO - Downloading blobuploader-1.2.4.tar.gz 16:30:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:30:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16: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 16: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 16: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 16: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 16: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 16: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 16:30:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:30:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16: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 16: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 16: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 16: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 16: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 16: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 16:30:07 INFO - Downloading docopt-0.6.1.tar.gz 16:30:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:30:07 INFO - Installing collected packages: blobuploader, requests, docopt 16:30:07 INFO - Running setup.py install for blobuploader 16:30:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:30:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:30:08 INFO - Running setup.py install for requests 16:30:08 INFO - Running setup.py install for docopt 16:30:08 INFO - Successfully installed blobuploader requests docopt 16:30:08 INFO - Cleaning up... 16:30:08 INFO - Return code: 0 16:30:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:08 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 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16:30:08 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 16:30:08 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 16:30:08 INFO - Using env: {'DISPLAY': ':0', 16:30:08 INFO - 'HOME': '/home/cltbld', 16:30:08 INFO - 'LANG': 'en_US.UTF-8', 16:30:08 INFO - 'LANGUAGE': 'en_US:en', 16:30:08 INFO - 'LOGNAME': 'cltbld', 16:30:08 INFO - 'MAIL': '/var/mail/cltbld', 16:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:08 INFO - 'MOZ_NO_REMOTE': '1', 16:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:08 INFO - 'NO_EM_RESTART': '1', 16:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:08 INFO - 'PWD': '/builds/slave/test', 16:30:08 INFO - 'SHELL': '/bin/bash', 16:30:08 INFO - 'SHLVL': '1', 16:30:08 INFO - 'TERM': 'linux', 16:30:08 INFO - 'TMOUT': '86400', 16:30:08 INFO - 'USER': 'cltbld', 16:30:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:08 INFO - '_': '/tools/buildbot/bin/python'} 16:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:08 INFO - Running setup.py (path:/tmp/pip-lLYjJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:08 INFO - Running setup.py (path:/tmp/pip-ozkbpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:08 INFO - Running setup.py (path:/tmp/pip-1QA_li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:08 INFO - Running setup.py (path:/tmp/pip-s_ImFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:09 INFO - Running setup.py (path:/tmp/pip-7DbhLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:09 INFO - Running setup.py (path:/tmp/pip-NxV0jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:09 INFO - Running setup.py (path:/tmp/pip-SDBj9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:09 INFO - Running setup.py (path:/tmp/pip-w0ZWvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:09 INFO - Running setup.py (path:/tmp/pip-xu_c98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:09 INFO - Running setup.py (path:/tmp/pip-Fh7TUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:09 INFO - Running setup.py (path:/tmp/pip-Ys05Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:09 INFO - Running setup.py (path:/tmp/pip-suAiKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:09 INFO - Running setup.py (path:/tmp/pip-cizL3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:09 INFO - Running setup.py (path:/tmp/pip-sT5G7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:09 INFO - Running setup.py (path:/tmp/pip-JYImow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:09 INFO - Running setup.py (path:/tmp/pip-vhp_hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:09 INFO - Running setup.py (path:/tmp/pip-DUVP3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:30:09 INFO - Running setup.py install for manifestparser 16:30:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozcrash 16:30:10 INFO - Running setup.py install for mozdebug 16:30:10 INFO - Running setup.py install for mozdevice 16:30:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozfile 16:30:10 INFO - Running setup.py install for mozhttpd 16:30:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozinfo 16:30:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozInstall 16:30:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for mozleak 16:30:10 INFO - Running setup.py install for mozlog 16:30:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:30:10 INFO - Running setup.py install for moznetwork 16:30:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Running setup.py install for mozprocess 16:30:11 INFO - Running setup.py install for mozprofile 16:30:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Running setup.py install for mozrunner 16:30:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Running setup.py install for mozscreenshot 16:30:11 INFO - Running setup.py install for moztest 16:30:11 INFO - Running setup.py install for mozversion 16:30:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:30:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:30:11 INFO - Cleaning up... 16:30:11 INFO - Return code: 0 16:30:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16: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')]} 16:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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', '-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 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:30:11 INFO - Using env: {'DISPLAY': ':0', 16:30:11 INFO - 'HOME': '/home/cltbld', 16:30:11 INFO - 'LANG': 'en_US.UTF-8', 16:30:11 INFO - 'LANGUAGE': 'en_US:en', 16:30:11 INFO - 'LOGNAME': 'cltbld', 16:30:11 INFO - 'MAIL': '/var/mail/cltbld', 16:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:11 INFO - 'MOZ_NO_REMOTE': '1', 16:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:11 INFO - 'NO_EM_RESTART': '1', 16:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:11 INFO - 'PWD': '/builds/slave/test', 16:30:11 INFO - 'SHELL': '/bin/bash', 16:30:11 INFO - 'SHLVL': '1', 16:30:11 INFO - 'TERM': 'linux', 16:30:11 INFO - 'TMOUT': '86400', 16:30:11 INFO - 'USER': 'cltbld', 16:30:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:11 INFO - '_': '/tools/buildbot/bin/python'} 16:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:11 INFO - Running setup.py (path:/tmp/pip-dtG8A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:12 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)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:12 INFO - Running setup.py (path:/tmp/pip-haxGkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:12 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)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:12 INFO - Running setup.py (path:/tmp/pip-p7NePD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:12 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)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:12 INFO - Running setup.py (path:/tmp/pip-MoAHmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:12 INFO - Running setup.py (path:/tmp/pip-hapfmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:12 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)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:12 INFO - Running setup.py (path:/tmp/pip-d0UHzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:12 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)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:12 INFO - Running setup.py (path:/tmp/pip-YPMnpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:12 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)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:12 INFO - Running setup.py (path:/tmp/pip-R3NeXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:12 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)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:12 INFO - Running setup.py (path:/tmp/pip-qUs3zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:12 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)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:12 INFO - Running setup.py (path:/tmp/pip-OTlmGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:12 INFO - Running setup.py (path:/tmp/pip-ilN69r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:12 INFO - Running setup.py (path:/tmp/pip-0ZXvof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:12 INFO - Running setup.py (path:/tmp/pip-0xq5nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:12 INFO - Running setup.py (path:/tmp/pip-CW6T4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:12 INFO - Running setup.py (path:/tmp/pip-WC5Uiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:13 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)) 16:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:13 INFO - Running setup.py (path:/tmp/pip-somZPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:13 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)) 16:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:13 INFO - Running setup.py (path:/tmp/pip-Ihpc9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:13 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)) 16:30:13 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)) 16:30:13 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)) 16:30:13 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)) 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16: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 16: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 16: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 16: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 16: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 16: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 16:30:14 INFO - Downloading blessings-1.5.1.tar.gz 16:30:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:30:14 INFO - Installing collected packages: blessings 16:30:14 INFO - Running setup.py install for blessings 16:30:15 INFO - Successfully installed blessings 16:30:15 INFO - Cleaning up... 16:30:15 INFO - Return code: 0 16:30:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:30:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:15 INFO - Reading from file tmpfile_stdout 16:30:15 INFO - Current package versions: 16:30:15 INFO - argparse == 1.2.1 16:30:15 INFO - blessings == 1.5.1 16:30:15 INFO - blobuploader == 1.2.4 16:30:15 INFO - docopt == 0.6.1 16:30:15 INFO - manifestparser == 1.1 16:30:15 INFO - mozInstall == 1.12 16:30:15 INFO - mozcrash == 0.16 16:30:15 INFO - mozdebug == 0.1 16:30:15 INFO - mozdevice == 0.48 16:30:15 INFO - mozfile == 1.2 16:30:15 INFO - mozhttpd == 0.7 16:30:15 INFO - mozinfo == 0.9 16:30:15 INFO - mozleak == 0.1 16:30:15 INFO - mozlog == 3.1 16:30:15 INFO - moznetwork == 0.27 16:30:15 INFO - mozprocess == 0.22 16:30:15 INFO - mozprofile == 0.28 16:30:15 INFO - mozrunner == 6.11 16:30:15 INFO - mozscreenshot == 0.1 16:30:15 INFO - mozsystemmonitor == 0.0 16:30:15 INFO - moztest == 0.7 16:30:15 INFO - mozversion == 1.4 16:30:15 INFO - psutil == 3.1.1 16:30:15 INFO - requests == 1.2.3 16:30:15 INFO - wsgiref == 0.1.2 16:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:15 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 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16:30:15 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 16:30:15 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 16:30:15 INFO - Using env: {'DISPLAY': ':0', 16:30:15 INFO - 'HOME': '/home/cltbld', 16:30:15 INFO - 'LANG': 'en_US.UTF-8', 16:30:15 INFO - 'LANGUAGE': 'en_US:en', 16:30:15 INFO - 'LOGNAME': 'cltbld', 16:30:15 INFO - 'MAIL': '/var/mail/cltbld', 16:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:15 INFO - 'MOZ_NO_REMOTE': '1', 16:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:15 INFO - 'NO_EM_RESTART': '1', 16:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:15 INFO - 'PWD': '/builds/slave/test', 16:30:15 INFO - 'SHELL': '/bin/bash', 16:30:15 INFO - 'SHLVL': '1', 16:30:15 INFO - 'TERM': 'linux', 16:30:15 INFO - 'TMOUT': '86400', 16:30:15 INFO - 'USER': 'cltbld', 16:30:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:15 INFO - '_': '/tools/buildbot/bin/python'} 16:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 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)) 16:30:15 INFO - Cleaning up... 16:30:15 INFO - Return code: 0 16:30:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:15 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 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16:30:15 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 16:30:15 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 16:30:15 INFO - Using env: {'DISPLAY': ':0', 16:30:15 INFO - 'HOME': '/home/cltbld', 16:30:15 INFO - 'LANG': 'en_US.UTF-8', 16:30:15 INFO - 'LANGUAGE': 'en_US:en', 16:30:15 INFO - 'LOGNAME': 'cltbld', 16:30:15 INFO - 'MAIL': '/var/mail/cltbld', 16:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:15 INFO - 'MOZ_NO_REMOTE': '1', 16:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:15 INFO - 'NO_EM_RESTART': '1', 16:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:15 INFO - 'PWD': '/builds/slave/test', 16:30:15 INFO - 'SHELL': '/bin/bash', 16:30:15 INFO - 'SHLVL': '1', 16:30:15 INFO - 'TERM': 'linux', 16:30:15 INFO - 'TMOUT': '86400', 16:30:15 INFO - 'USER': 'cltbld', 16:30:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:15 INFO - '_': '/tools/buildbot/bin/python'} 16:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:15 INFO - Downloading/unpacking jsonschema 16:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:30:17 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 16:30:17 INFO - Downloading/unpacking functools32 (from jsonschema) 16:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:30:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:30:17 INFO - warning: no files found matching '*.txt' 16:30:17 INFO - no previously-included directories found matching 'build' 16:30:17 INFO - no previously-included directories found matching 'dist' 16:30:17 INFO - no previously-included directories found matching '.git*' 16:30:17 INFO - Installing collected packages: jsonschema, functools32 16:30:17 INFO - Running setup.py install for functools32 16:30:17 INFO - warning: no files found matching '*.txt' 16:30:17 INFO - no previously-included directories found matching 'build' 16:30:17 INFO - no previously-included directories found matching 'dist' 16:30:17 INFO - no previously-included directories found matching '.git*' 16:30:17 INFO - Successfully installed jsonschema functools32 16:30:17 INFO - Cleaning up... 16:30:17 INFO - Return code: 0 16:30:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed2ea19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, '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': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', '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 16:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:30:17 INFO - Using env: {'DISPLAY': ':0', 16:30:17 INFO - 'HOME': '/home/cltbld', 16:30:17 INFO - 'LANG': 'en_US.UTF-8', 16:30:17 INFO - 'LANGUAGE': 'en_US:en', 16:30:17 INFO - 'LOGNAME': 'cltbld', 16:30:17 INFO - 'MAIL': '/var/mail/cltbld', 16:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:17 INFO - 'MOZ_NO_REMOTE': '1', 16:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:17 INFO - 'NO_EM_RESTART': '1', 16:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:17 INFO - 'PWD': '/builds/slave/test', 16:30:17 INFO - 'SHELL': '/bin/bash', 16:30:17 INFO - 'SHLVL': '1', 16:30:17 INFO - 'TERM': 'linux', 16:30:17 INFO - 'TMOUT': '86400', 16:30:17 INFO - 'USER': 'cltbld', 16:30:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:17 INFO - '_': '/tools/buildbot/bin/python'} 16:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:18 INFO - Downloading/unpacking flake8 16:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:30:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:30:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:30:20 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 16:30:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:20 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 16:30:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:30:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:30:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:30:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:30:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:30:20 INFO - no previously-included directories found matching 'docs/_build' 16:30:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:30:20 INFO - Running setup.py install for pep8 16:30:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:30:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:30:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:30:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:30:20 INFO - no previously-included directories found matching 'docs/_build' 16:30:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:30:20 INFO - Cleaning up... 16:30:20 INFO - Return code: 0 16:30:20 INFO - Running post-action listener: _resource_record_post_action 16:30:20 INFO - Running post-action listener: _start_resource_monitoring 16:30:20 INFO - Starting resource monitoring. 16:30:20 INFO - ##### 16:30:20 INFO - ##### Running install step. 16:30:20 INFO - ##### 16:30:20 INFO - Running pre-action listener: _resource_record_pre_action 16:30:20 INFO - Running main action method: install 16:30:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:20 INFO - Reading from file tmpfile_stdout 16:30:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:30:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:30:21 INFO - Reading from file tmpfile_stdout 16:30:21 INFO - Output received: 16:30:21 INFO - Usage: mozinstall [options] installer 16:30:21 INFO - Options: 16:30:21 INFO - -h, --help show this help message and exit 16:30:21 INFO - -d DEST, --destination=DEST 16:30:21 INFO - Directory to install application into. [default: 16:30:21 INFO - "/builds/slave/test"] 16:30:21 INFO - --app=APP Application being installed. [default: firefox] 16:30:21 INFO - mkdir: /builds/slave/test/build/application 16:30:21 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'] 16:30:21 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 16:30:36 INFO - Reading from file tmpfile_stdout 16:30:36 INFO - Output received: 16:30:36 INFO - /builds/slave/test/build/application/firefox/firefox 16:30:36 INFO - Running post-action listener: _resource_record_post_action 16:30:36 INFO - ##### 16:30:36 INFO - ##### Running run-tests step. 16:30:36 INFO - ##### 16:30:36 INFO - Running pre-action listener: _resource_record_pre_action 16:30:36 INFO - Running main action method: run_tests 16:30:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:30:36 INFO - Python 2.7.3 16:30:36 INFO - Return code: 0 16:30:36 INFO - grabbing minidump binary from tooltool 16:30:36 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')]} 16:30:36 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 0x14993d0>, '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 0x1404ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1405360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:30:36 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 16:30:36 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 16:30:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:30:36 INFO - Return code: 0 16:30:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:30:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:30:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:30:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:30:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:30:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:30:37 INFO - Return code: 0 16:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 16:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 16:30:37 INFO - Using env: {'DISPLAY': ':0', 16:30:37 INFO - 'HOME': '/home/cltbld', 16:30:37 INFO - 'LANG': 'en_US.UTF-8', 16:30:37 INFO - 'LANGUAGE': 'en_US:en', 16:30:37 INFO - 'LOGNAME': 'cltbld', 16:30:37 INFO - 'MAIL': '/var/mail/cltbld', 16:30:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:30:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:37 INFO - 'MOZ_NO_REMOTE': '1', 16:30:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:37 INFO - 'NO_EM_RESTART': '1', 16:30:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:37 INFO - 'PWD': '/builds/slave/test', 16:30:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:30:37 INFO - 'SHELL': '/bin/bash', 16:30:37 INFO - 'SHLVL': '1', 16:30:37 INFO - 'TERM': 'linux', 16:30:37 INFO - 'TMOUT': '86400', 16:30:37 INFO - 'USER': 'cltbld', 16:30:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883', 16:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:37 INFO - '_': '/tools/buildbot/bin/python'} 16:30:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 16:30:37 INFO - mozversion application_buildid: 20160114154357 16:30:37 INFO - mozversion application_changeset: 0d39fb92a77487fe494da2b3721815aa50cec625 16:30:37 INFO - mozversion application_display_name: Nightly 16:30:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:30:37 INFO - mozversion application_name: Firefox 16:30:37 INFO - mozversion application_remotingname: firefox 16:30:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:30:37 INFO - mozversion application_vendor: Mozilla 16:30:37 INFO - mozversion application_version: 46.0a1 16:30:37 INFO - mozversion platform_buildid: 20160114154357 16:30:37 INFO - mozversion platform_changeset: 0d39fb92a77487fe494da2b3721815aa50cec625 16:30:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:30:37 INFO - mozversion platform_version: 46.0a1 16:30:37 INFO - using testdate: 1452817837 16:30:37 INFO - actual date: 1452817837 16:30:37 INFO - starting webserver on 'localhost:54301' 16:30:37 INFO - SUITE-START | Running 3 tests 16:30:37 INFO - TEST-START | dromaeo_css 16:30:37 INFO - operating with platform_type : linux_ 16:30:37 INFO - Initialising browser for dromaeo_css test... 16:30:38 INFO - TEST-INFO | started process 4121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfEBNqj/profile http://localhost:54301/getInfo.html) 16:30:42 INFO - PROCESS | 4121 | __metrics Screen width/height:1600/1200 16:30:42 INFO - PROCESS | 4121 | colorDepth:24 16:30:42 INFO - PROCESS | 4121 | Browser inner width/height: 1024/697 16:30:42 INFO - PROCESS | 4121 | __metrics 16:30:42 INFO - PROCESS | 4121 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:30:43 INFO - PROCESS | 4121 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:30:43 INFO - TEST-INFO | 4121: exit 0 16:30:43 INFO - Browser initialized. 16:30:43 INFO - Running cycle 1/1 for dromaeo_css test... 16:30:43 INFO - TEST-INFO | started process 4218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfEBNqj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:55 INFO - PROCESS | 4218 | RSS: Main: 150245376 16:30:55 INFO - PROCESS | 4218 | 16:31:46 INFO - PROCESS | 4218 | 1452817906766 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] 16:33:58 INFO - PROCESS | 4218 | Cycle 1(1): loaded http://localhost:54301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54301/tests/dromaeo/cssquery-ext.html) 16:33:59 INFO - PROCESS | 4218 | RSS: Main: 233357312 16:33:59 INFO - PROCESS | 4218 | 16:37:01 INFO - PROCESS | 4218 | Cycle 1(1): loaded http://localhost:54301/tests/dromaeo/cssquery-ext.html (next: http://localhost:54301/tests/dromaeo/cssquery-jquery.html) 16:37:02 INFO - PROCESS | 4218 | RSS: Main: 227479552 16:37:02 INFO - PROCESS | 4218 | 16:40:04 INFO - PROCESS | 4218 | Cycle 1(1): loaded http://localhost:54301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54301/tests/dromaeo/cssquery-mootools.html) 16:40:05 INFO - PROCESS | 4218 | RSS: Main: 223768576 16:40:05 INFO - PROCESS | 4218 | 16:43:07 INFO - PROCESS | 4218 | Cycle 1(1): loaded http://localhost:54301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54301/tests/dromaeo/cssquery-prototype.html) 16:43:07 INFO - PROCESS | 4218 | RSS: Main: 208130048 16:43:07 INFO - PROCESS | 4218 | 16:46:10 INFO - PROCESS | 4218 | Cycle 1(1): loaded http://localhost:54301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54301/tests/dromaeo/cssquery-yui.html) 16:46:10 INFO - PROCESS | 4218 | RSS: Main: 213381120 16:46:10 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | Cycle 1(1): loaded http://localhost:54301/tests/dromaeo/cssquery-yui.html (next: http://localhost:54301/tests/dromaeo/cssquery-dojo.html) 16:49:13 INFO - PROCESS | 4218 | RSS: Main: 256196608 16:49:13 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | __start_tp_report 16:49:13 INFO - PROCESS | 4218 | _x_x_mozilla_page_load 16:49:13 INFO - PROCESS | 4218 | _x_x_mozilla_page_load_details 16:49:13 INFO - PROCESS | 4218 | |i|pagename|runs| 16:49:13 INFO - PROCESS | 4218 | |0;dojo.html;2584.224732580226;2626.435316406972;2627.6452678888345;2649.1125472966555;2661.0420248710466;4330.458692663417;4391.560843915607;4408.338749187619;4412.8455504057365;4433.334999750039;4422.204003279417;4459.375687403766;4468.486124095722;4494.8202071917085;4534;4123.237201117788;4151.916961660765;4191.0360617058095;4235.6187943085115;4239.512456067546;4009.1179940413062;4198.475190601175;4240.406343111967;4270.658347332206;4293.957060429402;4052.49343832021;4084.4690190275073;4099.89750256243;4111.177764447122;4145.7927103645;4079.16377142688;4080.6327430531396;4095.1195492969155;4101.097758493127;4122.814473348706;4019.974906398879;4077.4953812353383;4079.5920407958965;4088.632023117934;4139.4204811326435;4336.501302350239;4363.629091527192;4382.956170438287;4383.035732138925;4385.978070109629;4658.534146585348;4676.134915040729;4698.7650617469335;4795.592374648159;4804.111239420718;4803.063402636487;4828.927566086511;4841.70949743013;4842.297866809328;4879.097366987119;4485.461744590637;4497.707649002804;4501.707389019703;4536.319552067151;4538.909221815546;4708.552687494683;4788.329633851264;4798.856034318976;4803.471618122004;4880.145974454456;4718.009218064245;4719.056188762262;4722.220833562424;4735.573798358164;4768.3085952536685;4802.135615589227;4802.351682522884;4807.086653535817;4807.423109226916;4861.80552777892;4548.363229147922;4653.162430762495;4658.324542941323;4685.508021657745;4698.271767875985;4660.976695116503;4667.113248482778;4671.579557839811;4672.836450724276;4697.459792123949;3914.4911161548816;3933.783641899666;3940.369540873504;3960.029792700749;3963.8612648557164;3462.774919630216;3512.1746389598425;3514.4025515662397;3526.876559320463;3534.204803919149;4097.959020409758;4122.3404255319;4124.257633625916;4163.437935878678;4167.374893765959;4746.810127594927;4757.976210118996;4760.381150450488;4764.595009424238;4798.4001999750035;4033.3748269018347;4106.178764247163;4106.77412742302;4117.114820313647;4173.9773755430115;4207.684423668237;4218.135282267128;4219.831206751695;4239.40648309237;4255.851045213402;4486.820527178941;4498.910021799611;4500.2799552072165;4505.0764593258955;4537.77311134442;4675.275332323496;4759.833405830917;4759.904801904012;4769.046190761792;4797.688150270221;4491.7978690959635;4494.640428765625;4500.549945005604;4525.389072475174;4536.342230376643;4670.322803193586;4680.602148817253;4683.274092515666;4691.812327506861;4723.740194289209;4742.881427964328;4757.215059515142;4757.929465870152;4863.197572400514;4870.683405578626;4586.495485496659;4594.920193754532;4603.631709463168;4649.511801260955;4663.1839428099265;4610.446746390455;4615.353850460871;4623.56076172763;4623.86128416148;4664.603508701798;4507.774611269489;4530.524294949115;4532.478764941942;4537.478190008192;4590.219662657423;4637.304404339376;4652.232381656989;4656.813727451;4684.156851766715;4696.624270058455;4496.955030449653;4542.364069030405;4544.318352247189;4584.083183363274;4592.931106033479 16:49:13 INFO - PROCESS | 4218 | |1;ext.html;501.907147177772;503.25015726567426;503.96686792076235;516.7132241605909;531.1422053383785;25305.114320998768;25939.351516212082;33212.83393583035;33246.16884577887;33302.666973330226;36742.63257367426;37121.071973200684;37201.255974880485;37309.25381492375;37344.253114937754;6736.730530778763;6965.895511567331;7589.544627322364;7763.029621297338;7774.727884524043;9472.66845660402;9668.129868311851;9674.03259674034;9678.467684277362;9688.46713430761;9337.53312334384;9400.482973436458;9412.199963003153;9415.952920235424;9420.764480887965;9554.665586704466;9653.17947974423;9659.082387173208;9670.081342272542;9670.516474176264;9302.953485232598;9498.620055197784;9515.191208747265;9516.19112375449;9518.619255229782;36900.630993689985;37239.25521489582;37244.627553724655;37256.06859828526;37291;2694.245611228859;2956.3200463893427;3075.8154510729205;3279.177817794698;3607.494950706903;27030.5945410819;27131.864340678367;27432;27656.86171569129;27878.16365509038;3322.0864262327814;3339.7829141105994;3422.144463884029;3429;3486.3898817707054;173188.13405933016;174413;174415;174603.26983650893;174651.99999999872;47797.52202478;48963.75518122458;56254.43745562574;57600;57687.1346929788;49707.254391184164;49855.750721246164;50071.499285006685;50157.74921125444;50287.49712502828;13529.661758456117;13645.181289122684;13673.726525469634;13680.589582312547;13714.0400171989;10637.840432393521;10724.89275107239;10769;10772.084372828398;10863.565457381774;17999;18068.548286292684;18110;18185.818141818676;18276.634467310578;7329.157146928065;7654.119776225805;7726.111497177896;7728.922710772933;7745.728899488604;818.5784321074651;822.6914906909909;830;890.4434728294816;893.2764460786783;22846.8857655714;23196.3041108767;23255;23278.3016509505;23298.883505582362;939.6758118449125;1000.3997601439224;1008.0524307151401;1015.6749840051112;1021.3922715983978;12512.436940337706;12792.808107878389;12857.228566285865;12867.42096605655;12878.613641590768;304887;306625;309148;309928;310397;47795.522044779806;48326;48482.51517484851;48515.75742121338;48528;1177.8998785103363;1202.320688810819;1216.555957075661;1238.4674589926237;1251.5807204586383;18923.43229703111;25724;27803.16590502288;28568.85715571409;28569;42655.5734442664;43291;43315.13369732525;43320.56679433165;43343.56656433521;219974;223011;243641;245359;318617;29198.56202156927;29209.269768255963;29219.561706574845;29549.704502954693;29775.55336669995;36599.26801463903;37004.25991480209;37426.625733742316;37625;37686.434703478924;30538.694613053583;30959.845200773852;31100.37799243957;31545.8422707885;31889.681103188672;30454.238644034078;31303;31937.840310798296;34135.487967681;36389;32732.181695457803;32813.34373312568;32875.44787748259;32919.50620740739;33147.337053258314;26698.332541686614;27568.172954811387;29791.255218619706;31016.224594384417;31022.84488577633;21391;24456.75543244616;24903.875480622482;26599.33501662474;26841.463170736086 16:49:13 INFO - PROCESS | 4218 | |2;jquery.html;345.1165017555059;347.4961306106146;347.7774224496323;348.9424244999574;353.2370080625849;11764.647060588175;12212.633620991362;13976.09155404898;14276.214808185545;16048.75926861098;13019.47922083118;13322.533711320106;13453.394597243123;14236.359363828627;14256.857431425682;3958.2479328927557;4838.685485443435;4891.4619391867045;5007.399112106552;5046.772895219706;3649.5620525536974;3797.506324177853;4910.361652985125;5505.311836020497;5759;4803.3995750531185;5686.829395118153;5700.087985922253;5733.684647344395;5737.397573254811;4910.877228069309;4929;4935.481774413706;4962.3052772612045;4965.875853103666;4687.7656117194;4987.600991920638;4990.925136122961;5026.497350264981;5028.094942910275;10876.782464350668;11091.389973551451;13686.452541898312;17810.10949452535;17839.910800446043;1828.3783513605438;1835.6971099768523;1851.2965073272205;1903.3338331583834;1929.8842069475736;8538.44500107491;8554.871676924851;8723.912760872438;8845.203931646183;8862.379633425662;1652.702513547561;1688.6622675464955;1713.9057351845643;1722.2336060453104;1729;48945;49055.30745448308;50405.74797126027;51753.96492070137;52144;9376.8593471098;9657.275704322205;9722.416655000723;9735.1725103367;9790.461524616072;12377.62867113988;12399.938000310121;12418.503259869503;12423.937880310541;12430.254184748945;6695.062691223233;6712.664366781642;6748.257691654012;6768.796936091925;6790.0493930849725;6233.75064997395;6438.259600146043;6514.902276465857;6517.185351831021;6521.47828173745;3779.2063666630315;4071.9389209161886;4195.454590903163;4219.98720307124;4252.255855225323;1648.1676753239776;1661.3686799016295;1669.6994540982496;1670.448751911866;1718.905460199701;768.2125821033374;818.3698552114838;833.9499630022096;865.5109862927426;918.9753424931287;13808.861911380958;14423.84609231259;14702.632434189018;14902.180380078982;15603.453879114177;387.6181960768641;870.777951622345;887.8756974023642;902.747230775384;949.5252373813094;5098.490150984871;5149.510796474329;5297.311349524537;5355.758990845421;5412.702301373462;440697;445369;450096;452431;466759;57185;57480;57728.711356442946;63319.6834015827;65139;441.41292081531486;449.462891844243;453.12546784705836;453.716427232986;453.9954600454019;8861;9047.32145089134;9195.816083678155;9219;9266.11971862672;29169.854150729112;29724.554131687608;30157.69842301549;30319.545206821473;31191.220219494695;39820.40269395903;40420.79789601033;40473;40613.59386406098;42160.789196053825;6189.876202475835;6432.935670643234;6526.086347911391;6546;6785;8910.153535414125;9156.725298241063;9249.30630202724;9333.53332333367;9484.146426821619;5555.972220138873;7131.679074441558;7337.889931651136;8005.239502247277;8223.136570660234;7247.2390399007345;7694.807629809299;7743.341815945708;8083.19168083187;8207.630656620348;6253.437190652863;6797.898031529432;8090.838183236185;8316.459430137022;8417.854965874823;6458.838529036811;6652;6929;6943.930560694328;6994.286399832074;7501.437392195717;7786.922130778619;8050.959745201237;8112.797180070545;8172.141925097779 16:49:13 INFO - PROCESS | 4218 | |3;mootools.html;1273.6688461000138;1389.4511667891181;1406.4866323791819;1535.4932872152192;1750.1161913233816;6281.654509002003;6475.09348691183;7086.007958885753;7218.747343842967;7226;7337.26627337266;7373.115226172853;7435.144958329794;7441.665125069371;7444.292792184748;1773.0779994402903;1823.972640410395;2129.2973318804798;2156.7843215678386;2156.9029393677242;2107.9473013174716;2153.1602674956703;2155.3210738617363;2155.5365596396773;2164.9025793839237;2118.5339225370394;2118.8410869184795;2132.4562236629636;2148.7743786902383;2162.2107930605293;2112.281824179771;2123.819475344598;2127.5319429725437;2128.287023847013;2131.3499382688274;2198.483356411242;2213.7232845894264;2217.079911836586;2218.4786575154985;2219.5228025974493;7295.5987420691845;7323.121225452926;7329.74345897891;7330.560166389981;7350.522216055992;4254.425652536899;4355.216061108999;4366.8471603494045;4373.081652852873;4376.037271800199;2670.3724624713177;2796.608474813507;2806.340509980153;2810.1990932584117;2814.591884176783;847.7117779954783;863.8142799298118;870.1296770708952;875.916787905148;879.4635272483844;10154.9492252539;10170.491475426199;10175.542100605491;10200.13298869597;10229.590816367336;3933.3903244997073;4019.2765302245293;4070.9185816283507;4079.73481723687;4099.139180772012;8750.606222719865;8754.037055923844;8754.912450875538;8763.737087887373;8769.824603507894;4380.934285985712;4383.890402739957;4384.473863136444;4385.583369579885;4386.276264416336;3947.0527073502726;3962.7424217425773;3963.0290578808376;3963.365861462152;3964;3048.3750831079574;3099.271671157276;3441.1569165554097;3491.092315997859;3528.7000604948867;1076.5478499030426;1077.73595469109;1082.978340433187;1090.86909570852;1094.4527736131934;910.0808183734343;928.0255731481917;937.3204426790522;945.6548359848744;952.1335584617964;6525.249596296392;6576.539642224999;6591.967040164768;6622.86754264912;6625.138731964814;969.457104021736;995.1342332171057;1045.0959919669583;1052.4632437456953;1088.482970588964;5228.08508511009;5306.575473962073;5312.92030619541;5334.786608535615;5338.97330513345;8582.699605513777;8719.738407847775;8855.468671879707;9006.414583052081;9088.591013404413;8891.911080889238;8898.688545900863;8904.688335908211;8983.955080224689;8997.910020899708;6697.162854643169;6825.1127353443735;6924.376806087577;6994.265602111806;7002.1947476040905;6513.902291465726;6539.051837483443;6544.705488252945;6546.149000629887;6549;7845.6077196141105;7894.960525197337;8004.359651228005;8024.2376974187355;8122.472039317426;8013.439059265796;8176.754697359089;8178.713745018896;8251.546164960984;8289.792755180928;6108.083787431743;6286.308506064238;6400.743970241138;6423.004434312689;6445.452136568444;5774.94225057744;6422.775202867877;6501.349865013461;6515.250746164252;6525.9021114684265;5395.838124856261;5874.441928016831;5904.734286957011;5932.940670593239;6053.152558641882;5718.542516598745;5762.567807414377;5793.217915581343;5935.020721581063;5975.43233392827;6333.904991425225;6344.27040890285;6359.268684101387;6383.36166383358;6384.968075159594;5233.8018032427235;5302.575793936398;5303.231031500488;5306.97346513265;5325.414204437587;5426.294581704353;5481.205225242397;5497.45025497447;5497.835064948058;5498.230247765396 16:49:13 INFO - PROCESS | 4218 | |4;prototype.html;314.55333426534327;320.97753157279;323.1420578364442;328.5810591495844;332.9117783787298;5146.459621739715;5233.345831771028;5246.422893481714;5248.5276325130735;5265.973670131644;5194.142966410547;5194.220866869971;5194.558462530689;5196.506331898473;5210.9739451302785;3870.3613903705855;3962.5839286874752;3980.4029395590605;4121.381792731085;4127.667867654765;4033.0925541753163;4061;4066.755994640316;4067.5118985721756;4067.5932406759384;4036.3138266494766;4043.4945631796027;4044.312466880637;4054.9594504054876;4055.783265020497;3879.5538513071074;3964.2467931093;3981.28336899358;4028.8992775180564;4041.0503531670033;3597.334493118781;3604.9279014419826;3606.4770608261656;3610.3140403323287;3612.205314830733;4998.57512111471;5006.949930500685;5007.298978143063;5009.173486374744;5037.622178336603;4700.177468942921;4703.012367402849;4717.481077081518;4717.952820471785;4724.881877953045;5346.4118946915805;5452.91820622691;5459.262999495057;5466.01611709892;5481.5340696040885;3974.8608798691907;3978.0452691354158;3979.8607048753443;3980.980095099535;3982.283189025974;5658.830235092953;5758.654480731169;5762.423757624204;5763.798267060674;5769.278840144982;4077.7553346799286;4081.0409553754844;4082.3264161413626;4082.7346222495444;4086.5504794472586;4053.310937140693;4148.834046638161;4151.211269858717;4166.166766646683;4180.205760905418;4673.813047478131;4674.859754207379;4675.953240467552;4678.415198100238;4678.60231880294;5461.6996065216;5468.152436372368;5474.260974768435;5476.91784623231;5479.205515200353;1449.6303442622063;1457.2131049233508;1458.2052781234254;1458.555140682081;1459.0297452194384;1006.441425009127;1007.1942446043137;1013.614826365991;1013.6806905824642;1038.1642777563982;4814.5907597853875;4817.98822247332;4820.301056346881;4826.493218212107;4829.517048295213;5668.489835914705;5668.631538950038;5671.744771485293;5673.858153546194;5674.517665998354;4822.397200349957;4829.1307564638;4831.444383895827;4832.178529649968;4832.51674832521;2889.584103789128;2927.180389490946;2932.8386938718577;3034.2566071312226;3062.724354808078;5244.265802787613;5247.816326428557;5253.711045892513;5256.316678831728;5260.237265596544;5683.403242659461;5869.473936776469;5877.412258774174;5884.705764711833;5888.735006924699;5404.702741349263;5406.945930540723;5411.458854114557;5411.512963833274;5413.83758487246;5608.887822243614;5701.372848986691;5720.656760594377;5725;5730.512906402836;5592.552595792408;5592.664440133605;5593.748281327269;5594.804181853616;5595.35653399848;5387.75755091014;5399.163129714901;5399.244105825109;5403.108487099585;5406.135018397038;4111.958880411277;4112.444819949388;4114.958850411457;4115.753054816721;4117.485314335708;5545.528630066489;5697.4587414195585;5708.628939118944;5717;5723.255976723;5491.890162196653;5508.724563771875;5516.586256030733;5520.834374968757;5522.116461366162;5508.944910550843;5508.944910550843;5510.3938566758425;5518.475744804237;5522;5181.922271166011;5319.601029922848;5361.678299302054;5404.54061404785;5430.755615997368;5552.944470555404;5563.944360556505;5566.165075238585;5568.693721845176;5571.804986825442;5392.272043274108;5396.541293989898;5406.675599464044;5415.918761218506;5418.620696551204 16:49:13 INFO - PROCESS | 4218 | |5;yui.html;765.5521519910852;774.8334108166744;782.3780094824614;785.4227143049859;788.8619491588978;12668.429920653569;12949.41727622257;12950.158239714423;12961.481540738383;12997;11819.822702659467;11867.287962722243;11884.94057529711;11899.4050297485;11900.82148767767;599.4365296621162;608.2852648138442;766.7431410477483;773.7717373374868;780.9648565814553;791.9524828510308;793.6944276453578;795.4630624328584;796.928276455119;797.7726347990824;823.3125340340822;831.580052073702;833.212614079695;834.3033566971586;834.3658819297348;623.9563230573862;633.6578247746235;796.8326651403212;812.6140083460368;813.3574476163824;602.2381687165695;603.0893351039917;604.1903848842572;604.5828378418877;604.7762327938647;11460.942695286554;11515.25150865191;11520.366379849105;11527;11572.479238434207;10375.740606484898;10580.735481612945;10717.464126793708;10907.127429805596;10940.507677154546;8761.561921903944;9012.188902998761;9092.818143637156;9129.406588571788;9186.173244407968;2990.1179152150166;3056.938861222763;3070.800397974147;3084.722374986262;3090.9381812363627;38438.61561384378;38684;38743.225135497414;38833.805830970945;38938.221235575416;7701.345385642171;8200.83598328042;8513.318934485227;8547.273481753997;8582.570871456403;14768;14783.630409239855;14787.48243811483;14811.555653330417;14819.481318153812;6001.399860013964;6102.572819902653;6131.693415329216;6188.0717892315615;6246.937530624636;3466.8613255470004;3609.4766258892837;3613.187032917625;3642.817859107034;3662.7802331860175;2574.6395504629368;2589.1196993022463;2589.8575578342993;2592.0539003263675;2596.026490066225;457.2250036188695;469.258571457097;469.7064334790756;472.03704442936026;478.12741746313117;502.27170602626336;521.3014560488963;573.7418161827194;581.7236812514022;603.1345019896463;6957.8956315654295;7113.395361394236;7172.713091476283;7204.747833825791;7305.561666300039;479.53724655707407;516.2669010005726;560.4143669865001;586.135450210944;619.5477301569879;3452.9654703452643;3458.412069948115;3538.274653695986;3552.928941421157;3628.310620982005;43314;43660.126797463876;43708.12583748307;43772.3434148488;43980.78009609931;39273;39475.802620987284;39478;39852.60147398489;39859.20281594352;33977.150571235914;34078.31843363119;35069;35510.82244588812;35695.99999999948;7134.750283740044;7252.818679533054;7507.812304692427;7709.653065612173;7791.649375778217;28066.719332807228;28247.29381765472;28880.402690578627;29179.708202918548;29244.41511169722;35497.82251088728;35732;35971.82014089913;36494.4525832118;36623.90128296155;8854.380193386402;8878.955605221932;8900.510471923848;9178.311626627896;9317.953410232905;10217.216812990051;10295.07344339013;10415.53130109162;10418.322809017389;10761.838572421577;9875.851862222216;9969.252306077218;10127.544260508148;10149.49252537385;10231;9563.234941204826;9646.951765241129;9799.461029643438;9851.802963940538;9921.900780992097;9872.654457093968;9964.451955142536;10008.533402532006;10024.548895299875;10078.496075196357;7784.6886124554385;7808.726694565663;7934.6826126956585;8036.758897233092;8228.83542329138;8211.466254693425;8225.300849427866;8352;8366.790830229049;8478.117440070406 16:49:13 INFO - PROCESS | 4218 | __end_tp_report 16:49:13 INFO - PROCESS | 4218 | __start_cc_report 16:49:13 INFO - PROCESS | 4218 | _x_x_mozilla_cycle_collect,797 16:49:13 INFO - PROCESS | 4218 | __end_cc_report 16:49:13 INFO - PROCESS | 4218 | __startTimestamp1452818953662__endTimestamp 16:49:13 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | ------- Summary: start ------- 16:49:13 INFO - PROCESS | 4218 | Number of tests: 6 16:49:13 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | [#0] dojo.html Cycles:165 Average:4400.97 Median:4530.52 stddev:440.57 (9.7%) stddev-sans-first:418.23 16:49:13 INFO - PROCESS | 4218 | Values: 2584.2 2626.4 2627.6 2649.1 2661.0 4330.5 4391.6 4408.3 4412.8 4433.3 4422.2 4459.4 4468.5 4494.8 4534.0 4123.2 4151.9 4191.0 4235.6 4239.5 4009.1 4198.5 4240.4 4270.7 4294.0 4052.5 4084.5 4099.9 4111.2 4145.8 4079.2 4080.6 4095.1 4101.1 4122.8 4020.0 4077.5 4079.6 4088.6 4139.4 4336.5 4363.6 4383.0 4383.0 4386.0 4658.5 4676.1 4698.8 4795.6 4804.1 4803.1 4828.9 4841.7 4842.3 4879.1 4485.5 4497.7 4501.7 4536.3 4538.9 4708.6 4788.3 4798.9 4803.5 4880.1 4718.0 4719.1 4722.2 4735.6 4768.3 4802.1 4802.4 4807.1 4807.4 4861.8 4548.4 4653.2 4658.3 4685.5 4698.3 4661.0 4667.1 4671.6 4672.8 4697.5 3914.5 3933.8 3940.4 3960.0 3963.9 3462.8 3512.2 3514.4 3526.9 3534.2 4098.0 4122.3 4124.3 4163.4 4167.4 4746.8 4758.0 4760.4 4764.6 4798.4 4033.4 4106.2 4106.8 4117.1 4174.0 4207.7 4218.1 4219.8 4239.4 4255.9 4486.8 4498.9 4500.3 4505.1 4537.8 4675.3 4759.8 4759.9 4769.0 4797.7 4491.8 4494.6 4500.5 4525.4 4536.3 4670.3 4680.6 4683.3 4691.8 4723.7 4742.9 4757.2 4757.9 4863.2 4870.7 4586.5 4594.9 4603.6 4649.5 4663.2 4610.4 4615.4 4623.6 4623.9 4664.6 4507.8 4530.5 4532.5 4537.5 4590.2 4637.3 4652.2 4656.8 4684.2 4696.6 4497.0 4542.4 4544.3 4584.1 4592.9 16:49:13 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | [#1] ext.html Cycles:180 Average:40139.93 Median:32897.48 stddev:65719.29 (199.8%) stddev-sans-first:65836.26 16:49:13 INFO - PROCESS | 4218 | Values: 501.9 503.3 504.0 516.7 531.1 25305.1 25939.4 33212.8 33246.2 33302.7 36742.6 37121.1 37201.3 37309.3 37344.3 6736.7 6965.9 7589.5 7763.0 7774.7 9472.7 9668.1 9674.0 9678.5 9688.5 9337.5 9400.5 9412.2 9416.0 9420.8 9554.7 9653.2 9659.1 9670.1 9670.5 9303.0 9498.6 9515.2 9516.2 9518.6 36900.6 37239.3 37244.6 37256.1 37291.0 2694.2 2956.3 3075.8 3279.2 3607.5 27030.6 27131.9 27432.0 27656.9 27878.2 3322.1 3339.8 3422.1 3429.0 3486.4 173188.1 174413.0 174415.0 174603.3 174652.0 47797.5 48963.8 56254.4 57600.0 57687.1 49707.3 49855.8 50071.5 50157.7 50287.5 13529.7 13645.2 13673.7 13680.6 13714.0 10637.8 10724.9 10769.0 10772.1 10863.6 17999.0 18068.5 18110.0 18185.8 18276.6 7329.2 7654.1 7726.1 7728.9 7745.7 818.6 822.7 830.0 890.4 893.3 22846.9 23196.3 23255.0 23278.3 23298.9 939.7 1000.4 1008.1 1015.7 1021.4 12512.4 12792.8 12857.2 12867.4 12878.6 304887.0 306625.0 309148.0 309928.0 310397.0 47795.5 48326.0 48482.5 48515.8 48528.0 1177.9 1202.3 1216.6 1238.5 1251.6 18923.4 25724.0 27803.2 28568.9 28569.0 42655.6 43291.0 43315.1 43320.6 43343.6 219974.0 223011.0 243641.0 245359.0 318617.0 29198.6 29209.3 29219.6 29549.7 29775.6 36599.3 37004.3 37426.6 37625.0 37686.4 30538.7 30959.8 31100.4 31545.8 31889.7 30454.2 31303.0 31937.8 34135.5 36389.0 32732.2 32813.3 32875.4 32919.5 33147.3 26698.3 27568.2 29791.3 31016.2 31022.8 21391.0 24456.8 24903.9 26599.3 26841.5 16:49:13 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | [#2] jquery.html Cycles:180 Average:23246.04 Median:27716.92 stddev:73750.37 (266.1%) stddev-sans-first:73937.21 16:49:13 INFO - PROCESS | 4218 | Values: 345.1 347.5 347.8 348.9 353.2 11764.6 12212.6 13976.1 14276.2 16048.8 13019.5 13322.5 13453.4 14236.4 14256.9 3958.2 4838.7 4891.5 5007.4 5046.8 3649.6 3797.5 4910.4 5505.3 5759.0 4803.4 5686.8 5700.1 5733.7 5737.4 4910.9 4929.0 4935.5 4962.3 4965.9 4687.8 4987.6 4990.9 5026.5 5028.1 10876.8 11091.4 13686.5 17810.1 17839.9 1828.4 1835.7 1851.3 1903.3 1929.9 8538.4 8554.9 8723.9 8845.2 8862.4 1652.7 1688.7 1713.9 1722.2 1729.0 48945.0 49055.3 50405.7 51754.0 52144.0 9376.9 9657.3 9722.4 9735.2 9790.5 12377.6 12399.9 12418.5 12423.9 12430.3 6695.1 6712.7 6748.3 6768.8 6790.0 6233.8 6438.3 6514.9 6517.2 6521.5 3779.2 4071.9 4195.5 4220.0 4252.3 1648.2 1661.4 1669.7 1670.4 1718.9 768.2 818.4 833.9 865.5 919.0 13808.9 14423.8 14702.6 14902.2 15603.5 387.6 870.8 887.9 902.7 949.5 5098.5 5149.5 5297.3 5355.8 5412.7 440697.0 445369.0 450096.0 452431.0 466759.0 57185.0 57480.0 57728.7 63319.7 65139.0 441.4 449.5 453.1 453.7 454.0 8861.0 9047.3 9195.8 9219.0 9266.1 29169.9 29724.6 30157.7 30319.5 31191.2 39820.4 40420.8 40473.0 40613.6 42160.8 6189.9 6432.9 6526.1 6546.0 6785.0 8910.2 9156.7 9249.3 9333.5 9484.1 5556.0 7131.7 7337.9 8005.2 8223.1 7247.2 7694.8 7743.3 8083.2 8207.6 6253.4 6797.9 8090.8 8316.5 8417.9 6458.8 6652.0 6929.0 6943.9 6994.3 7501.4 7786.9 8051.0 8112.8 8172.1 16:49:13 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | [#3] mootools.html Cycles:180 Average:5003.75 Median:5768.76 stddev:2643.77 (45.8%) stddev-sans-first:2636.32 16:49:13 INFO - PROCESS | 4218 | Values: 1273.7 1389.5 1406.5 1535.5 1750.1 6281.7 6475.1 7086.0 7218.7 7226.0 7337.3 7373.1 7435.1 7441.7 7444.3 1773.1 1824.0 2129.3 2156.8 2156.9 2107.9 2153.2 2155.3 2155.5 2164.9 2118.5 2118.8 2132.5 2148.8 2162.2 2112.3 2123.8 2127.5 2128.3 2131.3 2198.5 2213.7 2217.1 2218.5 2219.5 7295.6 7323.1 7329.7 7330.6 7350.5 4254.4 4355.2 4366.8 4373.1 4376.0 2670.4 2796.6 2806.3 2810.2 2814.6 847.7 863.8 870.1 875.9 879.5 10154.9 10170.5 10175.5 10200.1 10229.6 3933.4 4019.3 4070.9 4079.7 4099.1 8750.6 8754.0 8754.9 8763.7 8769.8 4380.9 4383.9 4384.5 4385.6 4386.3 3947.1 3962.7 3963.0 3963.4 3964.0 3048.4 3099.3 3441.2 3491.1 3528.7 1076.5 1077.7 1083.0 1090.9 1094.5 910.1 928.0 937.3 945.7 952.1 6525.2 6576.5 6592.0 6622.9 6625.1 969.5 995.1 1045.1 1052.5 1088.5 5228.1 5306.6 5312.9 5334.8 5339.0 8582.7 8719.7 8855.5 9006.4 9088.6 8891.9 8898.7 8904.7 8984.0 8997.9 6697.2 6825.1 6924.4 6994.3 7002.2 6513.9 6539.1 6544.7 6546.1 6549.0 7845.6 7895.0 8004.4 8024.2 8122.5 8013.4 8176.8 8178.7 8251.5 8289.8 6108.1 6286.3 6400.7 6423.0 6445.5 5774.9 6422.8 6501.3 6515.3 6525.9 5395.8 5874.4 5904.7 5932.9 6053.2 5718.5 5762.6 5793.2 5935.0 5975.4 6333.9 6344.3 6359.3 6383.4 6385.0 5233.8 5302.6 5303.2 5307.0 5325.4 5426.3 5481.2 5497.5 5497.8 5498.2 16:49:13 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | [#4] prototype.html Cycles:180 Average:4577.75 Median:5164.19 stddev:1321.18 (25.6%) stddev-sans-first:1285.56 16:49:13 INFO - PROCESS | 4218 | Values: 314.6 321.0 323.1 328.6 332.9 5146.5 5233.3 5246.4 5248.5 5266.0 5194.1 5194.2 5194.6 5196.5 5211.0 3870.4 3962.6 3980.4 4121.4 4127.7 4033.1 4061.0 4066.8 4067.5 4067.6 4036.3 4043.5 4044.3 4055.0 4055.8 3879.6 3964.2 3981.3 4028.9 4041.1 3597.3 3604.9 3606.5 3610.3 3612.2 4998.6 5006.9 5007.3 5009.2 5037.6 4700.2 4703.0 4717.5 4718.0 4724.9 5346.4 5452.9 5459.3 5466.0 5481.5 3974.9 3978.0 3979.9 3981.0 3982.3 5658.8 5758.7 5762.4 5763.8 5769.3 4077.8 4081.0 4082.3 4082.7 4086.6 4053.3 4148.8 4151.2 4166.2 4180.2 4673.8 4674.9 4676.0 4678.4 4678.6 5461.7 5468.2 5474.3 5476.9 5479.2 1449.6 1457.2 1458.2 1458.6 1459.0 1006.4 1007.2 1013.6 1013.7 1038.2 4814.6 4818.0 4820.3 4826.5 4829.5 5668.5 5668.6 5671.7 5673.9 5674.5 4822.4 4829.1 4831.4 4832.2 4832.5 2889.6 2927.2 2932.8 3034.3 3062.7 5244.3 5247.8 5253.7 5256.3 5260.2 5683.4 5869.5 5877.4 5884.7 5888.7 5404.7 5406.9 5411.5 5411.5 5413.8 5608.9 5701.4 5720.7 5725.0 5730.5 5592.6 5592.7 5593.7 5594.8 5595.4 5387.8 5399.2 5399.2 5403.1 5406.1 4112.0 4112.4 4115.0 4115.8 4117.5 5545.5 5697.5 5708.6 5717.0 5723.3 5491.9 5508.7 5516.6 5520.8 5522.1 5508.9 5508.9 5510.4 5518.5 5522.0 5181.9 5319.6 5361.7 5404.5 5430.8 5552.9 5563.9 5566.2 5568.7 5571.8 5392.3 5396.5 5406.7 5415.9 5418.6 16:49:13 INFO - PROCESS | 4218 | 16:49:13 INFO - PROCESS | 4218 | [#5] yui.html Cycles:180 Average:11275.43 Median:478.83 stddev:12367.05 (2582.8%) stddev-sans-first:12376.56 16:49:13 INFO - PROCESS | 4218 | Values: 765.6 774.8 782.4 785.4 788.9 12668.4 12949.4 12950.2 12961.5 12997.0 11819.8 11867.3 11884.9 11899.4 11900.8 599.4 608.3 766.7 773.8 781.0 792.0 793.7 795.5 796.9 797.8 823.3 831.6 833.2 834.3 834.4 624.0 633.7 796.8 812.6 813.4 602.2 603.1 604.2 604.6 604.8 11460.9 11515.3 11520.4 11527.0 11572.5 10375.7 10580.7 10717.5 10907.1 10940.5 8761.6 9012.2 9092.8 9129.4 9186.2 2990.1 3056.9 3070.8 3084.7 3090.9 38438.6 38684.0 38743.2 38833.8 38938.2 7701.3 8200.8 8513.3 8547.3 8582.6 14768.0 14783.6 14787.5 14811.6 14819.5 6001.4 6102.6 6131.7 6188.1 6246.9 3466.9 3609.5 3613.2 3642.8 3662.8 2574.6 2589.1 2589.9 2592.1 2596.0 457.2 469.3 469.7 472.0 478.1 502.3 521.3 573.7 581.7 603.1 6957.9 7113.4 7172.7 7204.7 7305.6 479.5 516.3 560.4 586.1 619.5 3453.0 3458.4 3538.3 3552.9 3628.3 43314.0 43660.1 43708.1 43772.3 43980.8 39273.0 39475.8 39478.0 39852.6 39859.2 33977.2 34078.3 35069.0 35510.8 35696.0 7134.8 7252.8 7507.8 7709.7 7791.6 28066.7 28247.3 28880.4 29179.7 29244.4 35497.8 35732.0 35971.8 36494.5 36623.9 8854.4 8879.0 8900.5 9178.3 9318.0 10217.2 10295.1 10415.5 10418.3 10761.8 9875.9 9969.3 10127.5 10149.5 10231.0 9563.2 9647.0 9799.5 9851.8 9921.9 9872.7 9964.5 10008.5 10024.5 10078.5 7784.7 7808.7 7934.7 8036.8 8228.8 8211.5 8225.3 8352.0 8366.8 8478.1 16:49:13 INFO - PROCESS | 4218 | -------- Summary: end -------- 16:49:13 INFO - PROCESS | 4218 | 16:49:14 INFO - TEST-INFO | 4218: exit 0 16:49:14 INFO - TEST-OK | dromaeo_css | took 1116413ms 16:49:14 INFO - TEST-START | kraken 16:49:14 INFO - operating with platform_type : linux_ 16:49:14 INFO - Initialising browser for kraken test... 16:49:14 INFO - TEST-INFO | started process 4404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvr5ivl/profile http://localhost:54301/getInfo.html) 16:49:18 INFO - PROCESS | 4404 | __metrics Screen width/height:1600/1200 16:49:18 INFO - PROCESS | 4404 | colorDepth:24 16:49:18 INFO - PROCESS | 4404 | Browser inner width/height: 1024/697 16:49:18 INFO - PROCESS | 4404 | __metrics 16:49:18 INFO - PROCESS | 4404 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:49:18 INFO - PROCESS | 4404 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:49:20 INFO - TEST-INFO | 4404: exit 0 16:49:20 INFO - Browser initialized. 16:49:20 INFO - Running cycle 1/1 for kraken test... 16:49:20 INFO - TEST-INFO | started process 4484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvr5ivl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:32 INFO - PROCESS | 4484 | RSS: Main: 149950464 16:49:32 INFO - PROCESS | 4484 | 16:49:34 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54301/tests/kraken/driver.html?testName=audio-beat-detection) 16:49:35 INFO - PROCESS | 4484 | RSS: Main: 188223488 16:49:35 INFO - PROCESS | 4484 | 16:49:38 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54301/tests/kraken/driver.html?testName=audio-dft) 16:49:38 INFO - PROCESS | 4484 | RSS: Main: 178925568 16:49:38 INFO - PROCESS | 4484 | 16:49:41 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54301/tests/kraken/driver.html?testName=audio-fft) 16:49:42 INFO - PROCESS | 4484 | RSS: Main: 162758656 16:49:42 INFO - PROCESS | 4484 | 16:49:44 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54301/tests/kraken/driver.html?testName=audio-oscillator) 16:49:44 INFO - PROCESS | 4484 | RSS: Main: 165339136 16:49:44 INFO - PROCESS | 4484 | 16:49:47 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:49:47 INFO - PROCESS | 4484 | RSS: Main: 165994496 16:49:47 INFO - PROCESS | 4484 | 16:49:50 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54301/tests/kraken/driver.html?testName=imaging-darkroom) 16:49:51 INFO - PROCESS | 4484 | RSS: Main: 166957056 16:49:51 INFO - PROCESS | 4484 | 16:49:54 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54301/tests/kraken/driver.html?testName=imaging-desaturate) 16:49:55 INFO - PROCESS | 4484 | RSS: Main: 167084032 16:49:55 INFO - PROCESS | 4484 | 16:49:58 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54301/tests/kraken/driver.html?testName=json-parse-financial) 16:49:58 INFO - PROCESS | 4484 | RSS: Main: 167997440 16:49:58 INFO - PROCESS | 4484 | 16:50:00 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:50:00 INFO - PROCESS | 4484 | RSS: Main: 174694400 16:50:00 INFO - PROCESS | 4484 | 16:50:02 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54301/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:50:03 INFO - PROCESS | 4484 | RSS: Main: 172773376 16:50:03 INFO - PROCESS | 4484 | 16:50:05 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:50:06 INFO - PROCESS | 4484 | RSS: Main: 183427072 16:50:06 INFO - PROCESS | 4484 | 16:50:08 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:50:09 INFO - PROCESS | 4484 | RSS: Main: 189911040 16:50:09 INFO - PROCESS | 4484 | 16:50:11 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:50:12 INFO - PROCESS | 4484 | RSS: Main: 188428288 16:50:12 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | Cycle 1(1): loaded http://localhost:54301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54301/tests/kraken/driver.html?testName=ai-astar) 16:50:14 INFO - PROCESS | 4484 | RSS: Main: 245186560 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | __start_tp_report 16:50:14 INFO - PROCESS | 4484 | _x_x_mozilla_page_load 16:50:14 INFO - PROCESS | 4484 | _x_x_mozilla_page_load_details 16:50:14 INFO - PROCESS | 4484 | |i|pagename|runs| 16:50:14 INFO - PROCESS | 4484 | |0;ai-astar;112;114;107;112;112;112;103;113;114;111 16:50:14 INFO - PROCESS | 4484 | |1;audio-beat-detection;156;133;154;165;133;166;154;142;179;136 16:50:14 INFO - PROCESS | 4484 | |2;audio-dft;160;161;161;160;160;161;162;162;161;162 16:50:14 INFO - PROCESS | 4484 | |3;audio-fft;72;74;97;95;74;75;72;101;96;72 16:50:14 INFO - PROCESS | 4484 | |4;audio-oscillator;98;98;146;97;99;99;134;96;97;131 16:50:14 INFO - PROCESS | 4484 | |5;imaging-gaussian-blur;110;110;110;110;109;109;110;109;111;110 16:50:14 INFO - PROCESS | 4484 | |6;imaging-darkroom;147;147;148;147;147;146;147;146;147;147 16:50:14 INFO - PROCESS | 4484 | |7;imaging-desaturate;96;95;95;96;96;95;96;96;95;96 16:50:14 INFO - PROCESS | 4484 | |8;json-parse-financial;69;70;69;68;68;69;68;78;67;67 16:50:14 INFO - PROCESS | 4484 | |9;json-stringify-tinderbox;67;67;67;67;67;68;67;68;69;68 16:50:14 INFO - PROCESS | 4484 | |10;stanford-crypto-aes;82;93;83;84;83;84;84;85;84;84 16:50:14 INFO - PROCESS | 4484 | |11;stanford-crypto-ccm;124;119;121;121;120;131;122;121;121;137 16:50:14 INFO - PROCESS | 4484 | |12;stanford-crypto-pbkdf2;135;145;146;150;147;148;145;145;149;145 16:50:14 INFO - PROCESS | 4484 | |13;stanford-crypto-sha256-iterative;70;69;69;70;73;70;71;70;72;69 16:50:14 INFO - PROCESS | 4484 | __end_tp_report 16:50:14 INFO - PROCESS | 4484 | __start_cc_report 16:50:14 INFO - PROCESS | 4484 | _x_x_mozilla_cycle_collect,999 16:50:14 INFO - PROCESS | 4484 | __end_cc_report 16:50:14 INFO - PROCESS | 4484 | __startTimestamp1452819014562__endTimestamp 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | ------- Summary: start ------- 16:50:14 INFO - PROCESS | 4484 | Number of tests: 14 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.43 (3.1%) stddev-sans-first:3.62 16:50:14 INFO - PROCESS | 4484 | Values: 112.0 114.0 107.0 112.0 112.0 112.0 103.0 113.0 114.0 111.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:155.00 stddev:15.62 (10.1%) stddev-sans-first:16.49 16:50:14 INFO - PROCESS | 4484 | Values: 156.0 133.0 154.0 165.0 133.0 166.0 154.0 142.0 179.0 136.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 16:50:14 INFO - PROCESS | 4484 | Values: 160.0 161.0 161.0 160.0 160.0 161.0 162.0 162.0 161.0 162.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#3] audio-fft Cycles:10 Average:82.80 Median:74.50 stddev:12.57 (16.9%) stddev-sans-first:12.71 16:50:14 INFO - PROCESS | 4484 | Values: 72.0 74.0 97.0 95.0 74.0 75.0 72.0 101.0 96.0 72.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:97.50 stddev:19.36 (19.9%) stddev-sans-first:20.09 16:50:14 INFO - PROCESS | 4484 | Values: 98.0 98.0 146.0 97.0 99.0 99.0 134.0 96.0 97.0 131.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 16:50:14 INFO - PROCESS | 4484 | Values: 110.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 111.0 110.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:50:14 INFO - PROCESS | 4484 | Values: 147.0 147.0 148.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:50:14 INFO - PROCESS | 4484 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#8] json-parse-financial Cycles:10 Average:69.30 Median:69.00 stddev:3.20 (4.6%) stddev-sans-first:3.39 16:50:14 INFO - PROCESS | 4484 | Values: 69.0 70.0 69.0 68.0 68.0 69.0 68.0 78.0 67.0 67.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 16:50:14 INFO - PROCESS | 4484 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 69.0 68.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.06 (3.6%) stddev-sans-first:3.10 16:50:14 INFO - PROCESS | 4484 | Values: 82.0 93.0 83.0 84.0 83.0 84.0 84.0 85.0 84.0 84.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:121.50 stddev:5.76 (4.7%) stddev-sans-first:6.10 16:50:14 INFO - PROCESS | 4484 | Values: 124.0 119.0 121.0 121.0 120.0 131.0 122.0 121.0 121.0 137.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:146.50 stddev:4.12 (2.8%) stddev-sans-first:1.94 16:50:14 INFO - PROCESS | 4484 | Values: 135.0 145.0 146.0 150.0 147.0 148.0 145.0 145.0 149.0 145.0 16:50:14 INFO - PROCESS | 4484 | 16:50:14 INFO - PROCESS | 4484 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 16:50:14 INFO - PROCESS | 4484 | Values: 70.0 69.0 69.0 70.0 73.0 70.0 71.0 70.0 72.0 69.0 16:50:14 INFO - PROCESS | 4484 | -------- Summary: end -------- 16:50:14 INFO - PROCESS | 4484 | 16:50:15 INFO - TEST-INFO | 4484: exit 0 16:50:15 INFO - TEST-OK | kraken | took 61140ms 16:50:15 INFO - TEST-START | v8_7 16:50:15 INFO - operating with platform_type : linux_ 16:50:15 INFO - Initialising browser for v8_7 test... 16:50:15 INFO - TEST-INFO | started process 4732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppzr1k9/profile http://localhost:54301/getInfo.html) 16:50:20 INFO - PROCESS | 4732 | __metrics Screen width/height:1600/1200 16:50:20 INFO - PROCESS | 4732 | colorDepth:24 16:50:20 INFO - PROCESS | 4732 | Browser inner width/height: 1024/697 16:50:20 INFO - PROCESS | 4732 | __metrics 16:50:20 INFO - PROCESS | 4732 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:50:20 INFO - PROCESS | 4732 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:21 INFO - TEST-INFO | 4732: exit 0 16:50:21 INFO - Browser initialized. 16:50:21 INFO - Running cycle 1/1 for v8_7 test... 16:50:21 INFO - TEST-INFO | started process 4817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppzr1k9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:33 INFO - PROCESS | 4817 | RSS: Main: 149716992 16:50:33 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:54301/tests/v8_7/run.html (next: http://localhost:54301/tests/v8_7/run.html) 16:50:55 INFO - PROCESS | 4817 | RSS: Main: 479096832 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | __start_tp_report 16:50:55 INFO - PROCESS | 4817 | _x_x_mozilla_page_load 16:50:55 INFO - PROCESS | 4817 | _x_x_mozilla_page_load_details 16:50:55 INFO - PROCESS | 4817 | |i|pagename|runs| 16:50:55 INFO - PROCESS | 4817 | |0;Richards;166.75004168751042 16:50:55 INFO - PROCESS | 4817 | |1;DeltaBlue;188.43037497644622 16:50:55 INFO - PROCESS | 4817 | |2;Encrypt;277.85495971103086 16:50:55 INFO - PROCESS | 4817 | |3;Decrypt;5175.257731958763 16:50:55 INFO - PROCESS | 4817 | |4;RayTrace;1996.007984031936 16:50:55 INFO - PROCESS | 4817 | |5;Earley;817.8104575163399 16:50:55 INFO - PROCESS | 4817 | |6;Boyer;12712.5 16:50:55 INFO - PROCESS | 4817 | |7;RegExp;43212.765957446805 16:50:55 INFO - PROCESS | 4817 | |8;Splay;678.8866259334691 16:50:55 INFO - PROCESS | 4817 | |9;NavierStokes;4830.917874396136 16:50:55 INFO - PROCESS | 4817 | __end_tp_report 16:50:55 INFO - PROCESS | 4817 | __startTimestamp1452819055976__endTimestamp 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | ------- Summary: start ------- 16:50:55 INFO - PROCESS | 4817 | Number of tests: 10 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 166.8 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 188.4 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 277.9 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 5175.3 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 1996.0 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#5] Earley Cycles:1 Average:817.81 Median:817.81 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 817.8 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#6] Boyer Cycles:1 Average:12712.50 Median:12712.50 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 12712.5 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#7] RegExp Cycles:1 Average:43212.77 Median:43212.77 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 43212.8 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#8] Splay Cycles:1 Average:678.89 Median:678.89 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 678.9 16:50:55 INFO - PROCESS | 4817 | 16:50:55 INFO - PROCESS | 4817 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:50:55 INFO - PROCESS | 4817 | Values: 4830.9 16:50:55 INFO - PROCESS | 4817 | -------- Summary: end -------- 16:50:55 INFO - PROCESS | 4817 | 16:50:56 INFO - TEST-INFO | 4817: exit 0 16:50:56 INFO - TEST-OK | v8_7 | took 41350ms 16:50:56 INFO - SUITE-END | took 1218s 16:50:56 INFO - Completed test suite (00:20:18) 16:50:56 INFO - Working with test: dromaeo_css 16:50:56 INFO - Generating results file: dromaeo_css 16:50:56 INFO - Working with test: kraken 16:50:56 INFO - Generating results file: kraken 16:50:56 INFO - javascript benchmark 16:50:56 INFO - Working with test: v8_7 16:50:56 INFO - Generating results file: v8_7 16:50:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:50:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 16:50:57 INFO - process_Request line: dromaeo_css 5997.43 graph.html#tests=[[72,132,35]] 16:50:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:50:57 INFO - process_Request line: kraken 1529.30 graph.html#tests=[[232,132,35]] 16:50:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:50:57 INFO - process_Request line: v8_7 18525.17 graph.html#tests=[[230,132,35]] 16:50:57 INFO - RETURN: dromaeo_css: 5997.43 16:50:57 INFO - RETURN: kraken: 1529.30 16:50:57 INFO - RETURN: v8_7: 18525.17 16:50:57 INFO - javascript benchmark 16:50:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2584.224732580226, 2626.435316406972, 2627.6452678888345, 2649.1125472966555, 2661.0420248710466, 4330.458692663417, 4391.560843915607, 4408.338749187619, 4412.8455504057365, 4433.334999750039, 4422.204003279417, 4459.375687403766, 4468.486124095722, 4494.8202071917085, 4534.0, 4123.237201117788, 4151.916961660765, 4191.0360617058095, 4235.6187943085115, 4239.512456067546, 4009.1179940413062, 4198.475190601175, 4240.406343111967, 4270.658347332206, 4293.957060429402, 4052.49343832021, 4084.4690190275073, 4099.89750256243, 4111.177764447122, 4145.7927103645, 4079.16377142688, 4080.6327430531396, 4095.1195492969155, 4101.097758493127, 4122.814473348706, 4019.974906398879, 4077.4953812353383, 4079.5920407958965, 4088.632023117934, 4139.4204811326435, 4336.501302350239, 4363.629091527192, 4382.956170438287, 4383.035732138925, 4385.978070109629, 4658.534146585348, 4676.134915040729, 4698.7650617469335, 4795.592374648159, 4804.111239420718, 4803.063402636487, 4828.927566086511, 4841.70949743013, 4842.297866809328, 4879.097366987119, 4485.461744590637, 4497.707649002804, 4501.707389019703, 4536.319552067151, 4538.909221815546, 4708.552687494683, 4788.329633851264, 4798.856034318976, 4803.471618122004, 4880.145974454456, 4718.009218064245, 4719.056188762262, 4722.220833562424, 4735.573798358164, 4768.3085952536685, 4802.135615589227, 4802.351682522884, 4807.086653535817, 4807.423109226916, 4861.80552777892, 4548.363229147922, 4653.162430762495, 4658.324542941323, 4685.508021657745, 4698.271767875985, 4660.976695116503, 4667.113248482778, 4671.579557839811, 4672.836450724276, 4697.459792123949, 3914.4911161548816, 3933.783641899666, 3940.369540873504, 3960.029792700749, 3963.8612648557164, 3462.774919630216, 3512.1746389598425, 3514.4025515662397, 3526.876559320463, 3534.204803919149, 4097.959020409758, 4122.3404255319, 4124.257633625916, 4163.437935878678, 4167.374893765959, 4746.810127594927, 4757.976210118996, 4760.381150450488, 4764.595009424238, 4798.4001999750035, 4033.3748269018347, 4106.178764247163, 4106.77412742302, 4117.114820313647, 4173.9773755430115, 4207.684423668237, 4218.135282267128, 4219.831206751695, 4239.40648309237, 4255.851045213402, 4486.820527178941, 4498.910021799611, 4500.2799552072165, 4505.0764593258955, 4537.77311134442, 4675.275332323496, 4759.833405830917, 4759.904801904012, 4769.046190761792, 4797.688150270221, 4491.7978690959635, 4494.640428765625, 4500.549945005604, 4525.389072475174, 4536.342230376643, 4670.322803193586, 4680.602148817253, 4683.274092515666, 4691.812327506861, 4723.740194289209, 4742.881427964328, 4757.215059515142, 4757.929465870152, 4863.197572400514, 4870.683405578626, 4586.495485496659, 4594.920193754532, 4603.631709463168, 4649.511801260955, 4663.1839428099265, 4610.446746390455, 4615.353850460871, 4623.56076172763, 4623.86128416148, 4664.603508701798, 4507.774611269489, 4530.524294949115, 4532.478764941942, 4537.478190008192, 4590.219662657423, 4637.304404339376, 4652.232381656989, 4656.813727451, 4684.156851766715, 4696.624270058455, 4496.955030449653, 4542.364069030405, 4544.318352247189, 4584.083183363274, 4592.931106033479], "unit": "score", "name": "dojo.html", "value": 4374.789304770594}, {"lowerIsBetter": false, "replicates": [501.907147177772, 503.25015726567426, 503.96686792076235, 516.7132241605909, 531.1422053383785, 25305.114320998768, 25939.351516212082, 33212.83393583035, 33246.16884577887, 33302.666973330226, 36742.63257367426, 37121.071973200684, 37201.255974880485, 37309.25381492375, 37344.253114937754, 6736.730530778763, 6965.895511567331, 7589.544627322364, 7763.029621297338, 7774.727884524043, 9472.66845660402, 9668.129868311851, 9674.03259674034, 9678.467684277362, 9688.46713430761, 9337.53312334384, 9400.482973436458, 9412.199963003153, 9415.952920235424, 9420.764480887965, 9554.665586704466, 9653.17947974423, 9659.082387173208, 9670.081342272542, 9670.516474176264, 9302.953485232598, 9498.620055197784, 9515.191208747265, 9516.19112375449, 9518.619255229782, 36900.630993689985, 37239.25521489582, 37244.627553724655, 37256.06859828526, 37291.0, 2694.245611228859, 2956.3200463893427, 3075.8154510729205, 3279.177817794698, 3607.494950706903, 27030.5945410819, 27131.864340678367, 27432.0, 27656.86171569129, 27878.16365509038, 3322.0864262327814, 3339.7829141105994, 3422.144463884029, 3429.0, 3486.3898817707054, 173188.13405933016, 174413.0, 174415.0, 174603.26983650893, 174651.99999999872, 47797.52202478, 48963.75518122458, 56254.43745562574, 57600.0, 57687.1346929788, 49707.254391184164, 49855.750721246164, 50071.499285006685, 50157.74921125444, 50287.49712502828, 13529.661758456117, 13645.181289122684, 13673.726525469634, 13680.589582312547, 13714.0400171989, 10637.840432393521, 10724.89275107239, 10769.0, 10772.084372828398, 10863.565457381774, 17999.0, 18068.548286292684, 18110.0, 18185.818141818676, 18276.634467310578, 7329.157146928065, 7654.119776225805, 7726.111497177896, 7728.922710772933, 7745.728899488604, 818.5784321074651, 822.6914906909909, 830.0, 890.4434728294816, 893.2764460786783, 22846.8857655714, 23196.3041108767, 23255.0, 23278.3016509505, 23298.883505582362, 939.6758118449125, 1000.3997601439224, 1008.0524307151401, 1015.6749840051112, 1021.3922715983978, 12512.436940337706, 12792.808107878389, 12857.228566285865, 12867.42096605655, 12878.613641590768, 304887.0, 306625.0, 309148.0, 309928.0, 310397.0, 47795.522044779806, 48326.0, 48482.51517484851, 48515.75742121338, 48528.0, 1177.8998785103363, 1202.320688810819, 1216.555957075661, 1238.4674589926237, 1251.5807204586383, 18923.43229703111, 25724.0, 27803.16590502288, 28568.85715571409, 28569.0, 42655.5734442664, 43291.0, 43315.13369732525, 43320.56679433165, 43343.56656433521, 219974.0, 223011.0, 243641.0, 245359.0, 318617.0, 29198.56202156927, 29209.269768255963, 29219.561706574845, 29549.704502954693, 29775.55336669995, 36599.26801463903, 37004.25991480209, 37426.625733742316, 37625.0, 37686.434703478924, 30538.694613053583, 30959.845200773852, 31100.37799243957, 31545.8422707885, 31889.681103188672, 30454.238644034078, 31303.0, 31937.840310798296, 34135.487967681, 36389.0, 32732.181695457803, 32813.34373312568, 32875.44787748259, 32919.50620740739, 33147.337053258314, 26698.332541686614, 27568.172954811387, 29791.255218619706, 31016.224594384417, 31022.84488577633, 21391.0, 24456.75543244616, 24903.875480622482, 26599.33501662474, 26841.463170736086], "unit": "score", "name": "ext.html", "value": 16779.288748443294}, {"lowerIsBetter": false, "replicates": [345.1165017555059, 347.4961306106146, 347.7774224496323, 348.9424244999574, 353.2370080625849, 11764.647060588175, 12212.633620991362, 13976.09155404898, 14276.214808185545, 16048.75926861098, 13019.47922083118, 13322.533711320106, 13453.394597243123, 14236.359363828627, 14256.857431425682, 3958.2479328927557, 4838.685485443435, 4891.4619391867045, 5007.399112106552, 5046.772895219706, 3649.5620525536974, 3797.506324177853, 4910.361652985125, 5505.311836020497, 5759.0, 4803.3995750531185, 5686.829395118153, 5700.087985922253, 5733.684647344395, 5737.397573254811, 4910.877228069309, 4929.0, 4935.481774413706, 4962.3052772612045, 4965.875853103666, 4687.7656117194, 4987.600991920638, 4990.925136122961, 5026.497350264981, 5028.094942910275, 10876.782464350668, 11091.389973551451, 13686.452541898312, 17810.10949452535, 17839.910800446043, 1828.3783513605438, 1835.6971099768523, 1851.2965073272205, 1903.3338331583834, 1929.8842069475736, 8538.44500107491, 8554.871676924851, 8723.912760872438, 8845.203931646183, 8862.379633425662, 1652.702513547561, 1688.6622675464955, 1713.9057351845643, 1722.2336060453104, 1729.0, 48945.0, 49055.30745448308, 50405.74797126027, 51753.96492070137, 52144.0, 9376.8593471098, 9657.275704322205, 9722.416655000723, 9735.1725103367, 9790.461524616072, 12377.62867113988, 12399.938000310121, 12418.503259869503, 12423.937880310541, 12430.254184748945, 6695.062691223233, 6712.664366781642, 6748.257691654012, 6768.796936091925, 6790.0493930849725, 6233.75064997395, 6438.259600146043, 6514.902276465857, 6517.185351831021, 6521.47828173745, 3779.2063666630315, 4071.9389209161886, 4195.454590903163, 4219.98720307124, 4252.255855225323, 1648.1676753239776, 1661.3686799016295, 1669.6994540982496, 1670.448751911866, 1718.905460199701, 768.2125821033374, 818.3698552114838, 833.9499630022096, 865.5109862927426, 918.9753424931287, 13808.861911380958, 14423.84609231259, 14702.632434189018, 14902.180380078982, 15603.453879114177, 387.6181960768641, 870.777951622345, 887.8756974023642, 902.747230775384, 949.5252373813094, 5098.490150984871, 5149.510796474329, 5297.311349524537, 5355.758990845421, 5412.702301373462, 440697.0, 445369.0, 450096.0, 452431.0, 466759.0, 57185.0, 57480.0, 57728.711356442946, 63319.6834015827, 65139.0, 441.41292081531486, 449.462891844243, 453.12546784705836, 453.716427232986, 453.9954600454019, 8861.0, 9047.32145089134, 9195.816083678155, 9219.0, 9266.11971862672, 29169.854150729112, 29724.554131687608, 30157.69842301549, 30319.545206821473, 31191.220219494695, 39820.40269395903, 40420.79789601033, 40473.0, 40613.59386406098, 42160.789196053825, 6189.876202475835, 6432.935670643234, 6526.086347911391, 6546.0, 6785.0, 8910.153535414125, 9156.725298241063, 9249.30630202724, 9333.53332333367, 9484.146426821619, 5555.972220138873, 7131.679074441558, 7337.889931651136, 8005.239502247277, 8223.136570660234, 7247.2390399007345, 7694.807629809299, 7743.341815945708, 8083.19168083187, 8207.630656620348, 6253.437190652863, 6797.898031529432, 8090.838183236185, 8316.459430137022, 8417.854965874823, 6458.838529036811, 6652.0, 6929.0, 6943.930560694328, 6994.286399832074, 7501.437392195717, 7786.922130778619, 8050.959745201237, 8112.797180070545, 8172.141925097779], "unit": "score", "name": "jquery.html", "value": 6875.35676057617}, {"lowerIsBetter": false, "replicates": [1273.6688461000138, 1389.4511667891181, 1406.4866323791819, 1535.4932872152192, 1750.1161913233816, 6281.654509002003, 6475.09348691183, 7086.007958885753, 7218.747343842967, 7226.0, 7337.26627337266, 7373.115226172853, 7435.144958329794, 7441.665125069371, 7444.292792184748, 1773.0779994402903, 1823.972640410395, 2129.2973318804798, 2156.7843215678386, 2156.9029393677242, 2107.9473013174716, 2153.1602674956703, 2155.3210738617363, 2155.5365596396773, 2164.9025793839237, 2118.5339225370394, 2118.8410869184795, 2132.4562236629636, 2148.7743786902383, 2162.2107930605293, 2112.281824179771, 2123.819475344598, 2127.5319429725437, 2128.287023847013, 2131.3499382688274, 2198.483356411242, 2213.7232845894264, 2217.079911836586, 2218.4786575154985, 2219.5228025974493, 7295.5987420691845, 7323.121225452926, 7329.74345897891, 7330.560166389981, 7350.522216055992, 4254.425652536899, 4355.216061108999, 4366.8471603494045, 4373.081652852873, 4376.037271800199, 2670.3724624713177, 2796.608474813507, 2806.340509980153, 2810.1990932584117, 2814.591884176783, 847.7117779954783, 863.8142799298118, 870.1296770708952, 875.916787905148, 879.4635272483844, 10154.9492252539, 10170.491475426199, 10175.542100605491, 10200.13298869597, 10229.590816367336, 3933.3903244997073, 4019.2765302245293, 4070.9185816283507, 4079.73481723687, 4099.139180772012, 8750.606222719865, 8754.037055923844, 8754.912450875538, 8763.737087887373, 8769.824603507894, 4380.934285985712, 4383.890402739957, 4384.473863136444, 4385.583369579885, 4386.276264416336, 3947.0527073502726, 3962.7424217425773, 3963.0290578808376, 3963.365861462152, 3964.0, 3048.3750831079574, 3099.271671157276, 3441.1569165554097, 3491.092315997859, 3528.7000604948867, 1076.5478499030426, 1077.73595469109, 1082.978340433187, 1090.86909570852, 1094.4527736131934, 910.0808183734343, 928.0255731481917, 937.3204426790522, 945.6548359848744, 952.1335584617964, 6525.249596296392, 6576.539642224999, 6591.967040164768, 6622.86754264912, 6625.138731964814, 969.457104021736, 995.1342332171057, 1045.0959919669583, 1052.4632437456953, 1088.482970588964, 5228.08508511009, 5306.575473962073, 5312.92030619541, 5334.786608535615, 5338.97330513345, 8582.699605513777, 8719.738407847775, 8855.468671879707, 9006.414583052081, 9088.591013404413, 8891.911080889238, 8898.688545900863, 8904.688335908211, 8983.955080224689, 8997.910020899708, 6697.162854643169, 6825.1127353443735, 6924.376806087577, 6994.265602111806, 7002.1947476040905, 6513.902291465726, 6539.051837483443, 6544.705488252945, 6546.149000629887, 6549.0, 7845.6077196141105, 7894.960525197337, 8004.359651228005, 8024.2376974187355, 8122.472039317426, 8013.439059265796, 8176.754697359089, 8178.713745018896, 8251.546164960984, 8289.792755180928, 6108.083787431743, 6286.308506064238, 6400.743970241138, 6423.004434312689, 6445.452136568444, 5774.94225057744, 6422.775202867877, 6501.349865013461, 6515.250746164252, 6525.9021114684265, 5395.838124856261, 5874.441928016831, 5904.734286957011, 5932.940670593239, 6053.152558641882, 5718.542516598745, 5762.567807414377, 5793.217915581343, 5935.020721581063, 5975.43233392827, 6333.904991425225, 6344.27040890285, 6359.268684101387, 6383.36166383358, 6384.968075159594, 5233.8018032427235, 5302.575793936398, 5303.231031500488, 5306.97346513265, 5325.414204437587, 5426.294581704353, 5481.205225242397, 5497.45025497447, 5497.835064948058, 5498.230247765396], "unit": "score", "name": "mootools.html", "value": 4096.0841574062915}, {"lowerIsBetter": false, "replicates": [314.55333426534327, 320.97753157279, 323.1420578364442, 328.5810591495844, 332.9117783787298, 5146.459621739715, 5233.345831771028, 5246.422893481714, 5248.5276325130735, 5265.973670131644, 5194.142966410547, 5194.220866869971, 5194.558462530689, 5196.506331898473, 5210.9739451302785, 3870.3613903705855, 3962.5839286874752, 3980.4029395590605, 4121.381792731085, 4127.667867654765, 4033.0925541753163, 4061.0, 4066.755994640316, 4067.5118985721756, 4067.5932406759384, 4036.3138266494766, 4043.4945631796027, 4044.312466880637, 4054.9594504054876, 4055.783265020497, 3879.5538513071074, 3964.2467931093, 3981.28336899358, 4028.8992775180564, 4041.0503531670033, 3597.334493118781, 3604.9279014419826, 3606.4770608261656, 3610.3140403323287, 3612.205314830733, 4998.57512111471, 5006.949930500685, 5007.298978143063, 5009.173486374744, 5037.622178336603, 4700.177468942921, 4703.012367402849, 4717.481077081518, 4717.952820471785, 4724.881877953045, 5346.4118946915805, 5452.91820622691, 5459.262999495057, 5466.01611709892, 5481.5340696040885, 3974.8608798691907, 3978.0452691354158, 3979.8607048753443, 3980.980095099535, 3982.283189025974, 5658.830235092953, 5758.654480731169, 5762.423757624204, 5763.798267060674, 5769.278840144982, 4077.7553346799286, 4081.0409553754844, 4082.3264161413626, 4082.7346222495444, 4086.5504794472586, 4053.310937140693, 4148.834046638161, 4151.211269858717, 4166.166766646683, 4180.205760905418, 4673.813047478131, 4674.859754207379, 4675.953240467552, 4678.415198100238, 4678.60231880294, 5461.6996065216, 5468.152436372368, 5474.260974768435, 5476.91784623231, 5479.205515200353, 1449.6303442622063, 1457.2131049233508, 1458.2052781234254, 1458.555140682081, 1459.0297452194384, 1006.441425009127, 1007.1942446043137, 1013.614826365991, 1013.6806905824642, 1038.1642777563982, 4814.5907597853875, 4817.98822247332, 4820.301056346881, 4826.493218212107, 4829.517048295213, 5668.489835914705, 5668.631538950038, 5671.744771485293, 5673.858153546194, 5674.517665998354, 4822.397200349957, 4829.1307564638, 4831.444383895827, 4832.178529649968, 4832.51674832521, 2889.584103789128, 2927.180389490946, 2932.8386938718577, 3034.2566071312226, 3062.724354808078, 5244.265802787613, 5247.816326428557, 5253.711045892513, 5256.316678831728, 5260.237265596544, 5683.403242659461, 5869.473936776469, 5877.412258774174, 5884.705764711833, 5888.735006924699, 5404.702741349263, 5406.945930540723, 5411.458854114557, 5411.512963833274, 5413.83758487246, 5608.887822243614, 5701.372848986691, 5720.656760594377, 5725.0, 5730.512906402836, 5592.552595792408, 5592.664440133605, 5593.748281327269, 5594.804181853616, 5595.35653399848, 5387.75755091014, 5399.163129714901, 5399.244105825109, 5403.108487099585, 5406.135018397038, 4111.958880411277, 4112.444819949388, 4114.958850411457, 4115.753054816721, 4117.485314335708, 5545.528630066489, 5697.4587414195585, 5708.628939118944, 5717.0, 5723.255976723, 5491.890162196653, 5508.724563771875, 5516.586256030733, 5520.834374968757, 5522.116461366162, 5508.944910550843, 5508.944910550843, 5510.3938566758425, 5518.475744804237, 5522.0, 5181.922271166011, 5319.601029922848, 5361.678299302054, 5404.54061404785, 5430.755615997368, 5552.944470555404, 5563.944360556505, 5566.165075238585, 5568.693721845176, 5571.804986825442, 5392.272043274108, 5396.541293989898, 5406.675599464044, 5415.918761218506, 5418.620696551204], "unit": "score", "name": "prototype.html", "value": 4163.9360970035295}, {"lowerIsBetter": false, "replicates": [765.5521519910852, 774.8334108166744, 782.3780094824614, 785.4227143049859, 788.8619491588978, 12668.429920653569, 12949.41727622257, 12950.158239714423, 12961.481540738383, 12997.0, 11819.822702659467, 11867.287962722243, 11884.94057529711, 11899.4050297485, 11900.82148767767, 599.4365296621162, 608.2852648138442, 766.7431410477483, 773.7717373374868, 780.9648565814553, 791.9524828510308, 793.6944276453578, 795.4630624328584, 796.928276455119, 797.7726347990824, 823.3125340340822, 831.580052073702, 833.212614079695, 834.3033566971586, 834.3658819297348, 623.9563230573862, 633.6578247746235, 796.8326651403212, 812.6140083460368, 813.3574476163824, 602.2381687165695, 603.0893351039917, 604.1903848842572, 604.5828378418877, 604.7762327938647, 11460.942695286554, 11515.25150865191, 11520.366379849105, 11527.0, 11572.479238434207, 10375.740606484898, 10580.735481612945, 10717.464126793708, 10907.127429805596, 10940.507677154546, 8761.561921903944, 9012.188902998761, 9092.818143637156, 9129.406588571788, 9186.173244407968, 2990.1179152150166, 3056.938861222763, 3070.800397974147, 3084.722374986262, 3090.9381812363627, 38438.61561384378, 38684.0, 38743.225135497414, 38833.805830970945, 38938.221235575416, 7701.345385642171, 8200.83598328042, 8513.318934485227, 8547.273481753997, 8582.570871456403, 14768.0, 14783.630409239855, 14787.48243811483, 14811.555653330417, 14819.481318153812, 6001.399860013964, 6102.572819902653, 6131.693415329216, 6188.0717892315615, 6246.937530624636, 3466.8613255470004, 3609.4766258892837, 3613.187032917625, 3642.817859107034, 3662.7802331860175, 2574.6395504629368, 2589.1196993022463, 2589.8575578342993, 2592.0539003263675, 2596.026490066225, 457.2250036188695, 469.258571457097, 469.7064334790756, 472.03704442936026, 478.12741746313117, 502.27170602626336, 521.3014560488963, 573.7418161827194, 581.7236812514022, 603.1345019896463, 6957.8956315654295, 7113.395361394236, 7172.713091476283, 7204.747833825791, 7305.561666300039, 479.53724655707407, 516.2669010005726, 560.4143669865001, 586.135450210944, 619.5477301569879, 3452.9654703452643, 3458.412069948115, 3538.274653695986, 3552.928941421157, 3628.310620982005, 43314.0, 43660.126797463876, 43708.12583748307, 43772.3434148488, 43980.78009609931, 39273.0, 39475.802620987284, 39478.0, 39852.60147398489, 39859.20281594352, 33977.150571235914, 34078.31843363119, 35069.0, 35510.82244588812, 35695.99999999948, 7134.750283740044, 7252.818679533054, 7507.812304692427, 7709.653065612173, 7791.649375778217, 28066.719332807228, 28247.29381765472, 28880.402690578627, 29179.708202918548, 29244.41511169722, 35497.82251088728, 35732.0, 35971.82014089913, 36494.4525832118, 36623.90128296155, 8854.380193386402, 8878.955605221932, 8900.510471923848, 9178.311626627896, 9317.953410232905, 10217.216812990051, 10295.07344339013, 10415.53130109162, 10418.322809017389, 10761.838572421577, 9875.851862222216, 9969.252306077218, 10127.544260508148, 10149.49252537385, 10231.0, 9563.234941204826, 9646.951765241129, 9799.461029643438, 9851.802963940538, 9921.900780992097, 9872.654457093968, 9964.451955142536, 10008.533402532006, 10024.548895299875, 10078.496075196357, 7784.6886124554385, 7808.726694565663, 7934.6826126956585, 8036.758897233092, 8228.83542329138, 8211.466254693425, 8225.300849427866, 8352.0, 8366.790830229049, 8478.117440070406], "unit": "score", "name": "yui.html", "value": 5405.639962312954}], "name": "dromaeo_css", "value": 5997.428479468701}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 107.0, 112.0, 112.0, 112.0, 103.0, 113.0, 114.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [156.0, 133.0, 154.0, 165.0, 133.0, 166.0, 154.0, 142.0, 179.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 151.8}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 97.0, 95.0, 74.0, 75.0, 72.0, 101.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 146.0, 97.0, 99.0, 99.0, 134.0, 96.0, 97.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 68.0, 68.0, 69.0, 68.0, 78.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [82.0, 93.0, 83.0, 84.0, 83.0, 84.0, 84.0, 85.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 121.0, 121.0, 120.0, 131.0, 122.0, 121.0, 121.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [135.0, 145.0, 146.0, 150.0, 147.0, 148.0, 145.0, 145.0, 149.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 70.0, 73.0, 70.0, 71.0, 70.0, 72.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1529.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [817.8104575163399], "unit": "score", "name": "Earley", "value": 814.9357762237764}, {"lowerIsBetter": false, "replicates": [12712.5], "unit": "score", "name": "Boyer", "value": 52.425801376597875}, {"lowerIsBetter": false, "replicates": [43212.765957446805], "unit": "score", "name": "RegExp", "value": 21.08138601674051}, {"lowerIsBetter": false, "replicates": [678.8866259334691], "unit": "score", "name": "Splay", "value": 120.03624300000007}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18525.16761039844}]} 16:50:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "18525.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1529.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5997.43"}}} 16:50:57 INFO - Return code: 0 16:50:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:50:57 INFO - # TBPL SUCCESS # 16:50:57 INFO - Running post-action listener: _resource_record_post_action 16:50:57 INFO - Running post-run listener: _resource_record_post_run 16:50:58 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 545992704; Read time: 0; Write time: 378548 16:50:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 145551360; Read time: 0; Write time: 95500 16:50:58 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 308764672; Read time: 0; Write time: 227792 16:50:58 INFO - Running post-run listener: _upload_blobber_files 16:50:58 INFO - Blob upload gear active. 16:50:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:50:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:50:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:50:58 INFO - (blobuploader) - INFO - Open directory for files ... 16:50:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:50:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:50:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:59 INFO - (blobuploader) - INFO - Done attempting. 16:50:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:50:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:51:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:00 INFO - (blobuploader) - INFO - Done attempting. 16:51:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:00 INFO - Return code: 0 16:51:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66823afa53ee834c8d486dbc5104746f62d21d480a56b6ef354f75edecfef2b906cbe0db2d42e58bd802b3e8b3e247ac1a9dee87dffed4c59c00669b45bbe7cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc3f7daa96a4094f9b1bdad662a09721aa124f7fd8f976f67e248a09acf891402f0d45af277754525a85da26d2bd57656e431f71e248102184c78d4c26c4730"} 16:51:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:00 INFO - Contents: 16:51:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66823afa53ee834c8d486dbc5104746f62d21d480a56b6ef354f75edecfef2b906cbe0db2d42e58bd802b3e8b3e247ac1a9dee87dffed4c59c00669b45bbe7cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc3f7daa96a4094f9b1bdad662a09721aa124f7fd8f976f67e248a09acf891402f0d45af277754525a85da26d2bd57656e431f71e248102184c78d4c26c4730"} 16:51:00 INFO - Copying logs to upload dir... 16:51:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.380412 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-14 16:51:00.012953) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 16:51:00.016886) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66823afa53ee834c8d486dbc5104746f62d21d480a56b6ef354f75edecfef2b906cbe0db2d42e58bd802b3e8b3e247ac1a9dee87dffed4c59c00669b45bbe7cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc3f7daa96a4094f9b1bdad662a09721aa124f7fd8f976f67e248a09acf891402f0d45af277754525a85da26d2bd57656e431f71e248102184c78d4c26c4730"} build_url:https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/STjj6zDhTbiHpw15XNcezA/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/Fx-Team-Non-PGO/sha512/66823afa53ee834c8d486dbc5104746f62d21d480a56b6ef354f75edecfef2b906cbe0db2d42e58bd802b3e8b3e247ac1a9dee87dffed4c59c00669b45bbe7cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc3f7daa96a4094f9b1bdad662a09721aa124f7fd8f976f67e248a09acf891402f0d45af277754525a85da26d2bd57656e431f71e248102184c78d4c26c4730"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 16:51:00.040992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:51:00.041292) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1452817780.686785-683174883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 16:51:00.126249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 16:51:00.126570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 16:51:00.126849) ========= ========= Total master_lag: 0.21 =========