builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1452857488.73 results: success (0) buildid: 20160115023944 builduid: 589caf218c0e423d9f4b9a7dc41168aa revision: 4c92836f188be7490401084802dd7c21ba75334a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.730833) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.731391) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.731713) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.767559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.767839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.782337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.782626) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.832266) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.832566) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.832908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:28.833187) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 03:31:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.7M=0s 2016-01-15 03:31:28 (29.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164785 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:29.011594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:29.011911) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:29.062026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:29.062589) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c92836f188be7490401084802dd7c21ba75334a --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 4c92836f188be7490401084802dd7c21ba75334a --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=652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 03:31:29,087 truncating revision to first 12 chars 2016-01-15 03:31:29,087 Setting DEBUG logging. 2016-01-15 03:31:29,087 attempt 1/10 2016-01-15 03:31:29,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c92836f188b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 03:31:29,676 unpacking tar archive at: fx-team-4c92836f188b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.917317 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:29.993015) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:29.993332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:30.003368) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:30.003701) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 03:31:30.004105) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-15 03:31:30.004382) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:30 INFO - MultiFileLogger online at 20160115 03:31:30 in /builds/slave/test 03:31:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:31:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:30 INFO - {'append_to_log': False, 03:31:30 INFO - 'base_work_dir': '/builds/slave/test', 03:31:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:31:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:30 INFO - 'branch': 'Fx-Team-Non-PGO', 03:31:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:30 INFO - 'config_files': ('talos/linux_config.py',), 03:31:30 INFO - 'default_actions': ('clobber', 03:31:30 INFO - 'read-buildbot-config', 03:31:30 INFO - 'download-and-extract', 03:31:30 INFO - 'populate-webroot', 03:31:30 INFO - 'create-virtualenv', 03:31:30 INFO - 'install', 03:31:30 INFO - 'run-tests'), 03:31:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:30 INFO - 'download_minidump_stackwalk': True, 03:31:30 INFO - 'download_symbols': 'ondemand', 03:31:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:30 INFO - 'installer_path': 'installer.exe', 03:31:30 INFO - 'log_level': 'info', 03:31:30 INFO - 'log_name': 'talos', 03:31:30 INFO - 'log_to_console': True, 03:31:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:30 INFO - 'opt_config_files': (), 03:31:30 INFO - 'pip_index': False, 03:31:30 INFO - 'sps_profile': False, 03:31:30 INFO - 'sps_profile_interval': 0, 03:31:30 INFO - 'suite': 'dromaeojs-e10s', 03:31:30 INFO - 'system_bits': '32', 03:31:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:30 INFO - 'title': 'talos-linux64-ix-046', 03:31:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:30 INFO - 'use_talos_json': True, 03:31:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:30 INFO - 'work_dir': 'build'} 03:31:30 INFO - ##### 03:31:30 INFO - ##### Running clobber step. 03:31:30 INFO - ##### 03:31:30 INFO - Running pre-action listener: _resource_record_pre_action 03:31:30 INFO - Running main action method: clobber 03:31:30 INFO - rmtree: /builds/slave/test/build 03:31:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:30 INFO - Running post-action listener: _resource_record_post_action 03:31:30 INFO - ##### 03:31:30 INFO - ##### Running read-buildbot-config step. 03:31:30 INFO - ##### 03:31:30 INFO - Running pre-action listener: _resource_record_pre_action 03:31:30 INFO - Running main action method: read_buildbot_config 03:31:30 INFO - Using buildbot properties: 03:31:30 INFO - { 03:31:30 INFO - "project": "", 03:31:30 INFO - "product": "firefox", 03:31:30 INFO - "script_repo_revision": "production", 03:31:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:31:30 INFO - "repository": "", 03:31:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:31:30 INFO - "buildid": "20160115023944", 03:31:30 INFO - "pgo_build": "False", 03:31:30 INFO - "basedir": "/builds/slave/test", 03:31:30 INFO - "buildnumber": 699, 03:31:30 INFO - "slavename": "talos-linux64-ix-046", 03:31:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:31:30 INFO - "platform": "ubuntu64_hw", 03:31:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:31:30 INFO - "branch": "fx-team", 03:31:30 INFO - "repo_path": "integration/fx-team", 03:31:30 INFO - "revision": "4c92836f188be7490401084802dd7c21ba75334a", 03:31:30 INFO - "stage_platform": "linux64", 03:31:30 INFO - "builduid": "589caf218c0e423d9f4b9a7dc41168aa", 03:31:30 INFO - "slavebuilddir": "test" 03:31:30 INFO - } 03:31:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:31:30 INFO - Running post-action listener: _resource_record_post_action 03:31:30 INFO - ##### 03:31:30 INFO - ##### Running download-and-extract step. 03:31:30 INFO - ##### 03:31:30 INFO - Running pre-action listener: _resource_record_pre_action 03:31:30 INFO - Running main action method: download_and_extract 03:31:30 INFO - mkdir: /builds/slave/test/build/tests 03:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:30 INFO - https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:31:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/test_packages.json 03:31:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/test_packages.json 03:31:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:31:31 INFO - Downloaded 1448 bytes. 03:31:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:31:31 INFO - Using the following test package requirements: 03:31:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:31 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:31:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:31 INFO - u'jsshell-linux-x86_64.zip'], 03:31:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:31:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:31:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:31 INFO - https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:31:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:31:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/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 03:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/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 03:31:33 INFO - Downloaded 21171066 bytes. 03:31:33 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'] 03:31:33 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 03:31:34 INFO - Return code: 0 03:31:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:34 INFO - https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/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 03:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/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 03:31:37 INFO - Downloaded 21171066 bytes. 03:31:37 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'] 03:31:37 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 03:31:38 INFO - Return code: 0 03:31:38 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')]} 03:31:38 INFO - https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/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 03:31:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/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 03:31:40 INFO - Downloaded 11132144 bytes. 03:31:40 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'] 03:31:40 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 03:31:40 INFO - Return code: 0 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:40 INFO - https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/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 03:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/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 03:31:43 INFO - Downloaded 54150640 bytes. 03:31:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:31:43 INFO - mkdir: /builds/slave/test/properties 03:31:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:43 INFO - Contents: 03:31:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:31:43 INFO - Running post-action listener: _resource_record_post_action 03:31:43 INFO - Running post-action listener: set_extra_try_arguments 03:31:43 INFO - ##### 03:31:43 INFO - ##### Running populate-webroot step. 03:31:43 INFO - ##### 03:31:43 INFO - Running pre-action listener: _resource_record_pre_action 03:31:43 INFO - Running main action method: populate_webroot 03:31:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:43 INFO - '--tppagecycles', 03:31:43 INFO - '7'], 03:31:43 INFO - 'tests': ['tsvgm']}}, 03:31:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:31:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:31:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:31:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:43 INFO - 'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:43 INFO - 'tests': ['damp', 'tps']}, 03:31:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:43 INFO - 'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['damp', 'tps']}, 03:31:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:31:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:43 INFO - 'other': {'tests': ['a11yr', 03:31:43 INFO - 'ts_paint', 03:31:43 INFO - 'tpaint', 03:31:43 INFO - 'sessionrestore', 03:31:43 INFO - 'sessionrestore_no_auto_restore']}, 03:31:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['a11yr', 03:31:43 INFO - 'ts_paint', 03:31:43 INFO - 'tpaint', 03:31:43 INFO - 'sessionrestore', 03:31:43 INFO - 'sessionrestore_no_auto_restore']}, 03:31:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['a11yr', 03:31:43 INFO - 'ts_paint', 03:31:43 INFO - 'tpaint', 03:31:43 INFO - 'sessionrestore', 03:31:43 INFO - 'sessionrestore_no_auto_restore']}, 03:31:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['a11yr', 03:31:43 INFO - 'ts_paint', 03:31:43 INFO - 'tpaint', 03:31:43 INFO - 'sessionrestore', 03:31:43 INFO - 'sessionrestore_no_auto_restore']}, 03:31:43 INFO - 'other_l64': {'tests': ['a11yr', 03:31:43 INFO - 'ts_paint', 03:31:43 INFO - 'tpaint', 03:31:43 INFO - 'sessionrestore', 03:31:43 INFO - 'sessionrestore_no_auto_restore']}, 03:31:43 INFO - 'other_nol64': {'tests': ['a11yr', 03:31:43 INFO - 'ts_paint', 03:31:43 INFO - 'tpaint', 03:31:43 INFO - 'sessionrestore', 03:31:43 INFO - 'sessionrestore_no_auto_restore']}, 03:31:43 INFO - 'svgr': {'tests': ['tsvgx', 03:31:43 INFO - 'tsvgr_opacity', 03:31:43 INFO - 'tart', 03:31:43 INFO - 'tscrollx', 03:31:43 INFO - 'cart']}, 03:31:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['tsvgx', 03:31:43 INFO - 'tsvgr_opacity', 03:31:43 INFO - 'tart', 03:31:43 INFO - 'tscrollx', 03:31:43 INFO - 'cart']}, 03:31:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:43 INFO - 'tests': ['tp5o']}, 03:31:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:43 INFO - 'talos_options': ['--e10s'], 03:31:43 INFO - 'tests': ['tp5o']}, 03:31:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:43 INFO - 'talos_options': ['--xperf_path', 03:31:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:43 INFO - 'tests': ['tp5n']}, 03:31:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:43 INFO - 'talos_options': ['--e10s', 03:31:43 INFO - '--xperf_path', 03:31:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:43 INFO - 'tests': ['tp5n']}}, 03:31:43 INFO - 'talos.zip': {'path': '', 03:31:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:43 INFO - Running post-action listener: _resource_record_post_action 03:31:43 INFO - ##### 03:31:43 INFO - ##### Running create-virtualenv step. 03:31:43 INFO - ##### 03:31:43 INFO - Running pre-action listener: _resource_record_pre_action 03:31:43 INFO - Running main action method: create_virtualenv 03:31:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:43 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 03:31:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:43 INFO - Using real prefix '/usr' 03:31:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:46 INFO - Installing pip.................done. 03:31:46 INFO - Return code: 0 03:31:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:31:46 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 03:31:46 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 03:31:46 INFO - Using env: {'DISPLAY': ':0', 03:31:46 INFO - 'HOME': '/home/cltbld', 03:31:46 INFO - 'LANG': 'en_US.UTF-8', 03:31:46 INFO - 'LANGUAGE': 'en_US:en', 03:31:46 INFO - 'LOGNAME': 'cltbld', 03:31:46 INFO - 'MAIL': '/var/mail/cltbld', 03:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:46 INFO - 'MOZ_NO_REMOTE': '1', 03:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:46 INFO - 'NO_EM_RESTART': '1', 03:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:46 INFO - 'PWD': '/builds/slave/test', 03:31:46 INFO - 'SHELL': '/bin/bash', 03:31:46 INFO - 'SHLVL': '1', 03:31:46 INFO - 'TERM': 'linux', 03:31:46 INFO - 'TMOUT': '86400', 03:31:46 INFO - 'USER': 'cltbld', 03:31:46 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:46 INFO - '_': '/tools/buildbot/bin/python'} 03:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:46 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 03:31:46 INFO - Cleaning up... 03:31:46 INFO - Return code: 0 03:31:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:31:46 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 03:31:46 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 03:31:46 INFO - Using env: {'DISPLAY': ':0', 03:31:46 INFO - 'HOME': '/home/cltbld', 03:31:46 INFO - 'LANG': 'en_US.UTF-8', 03:31:46 INFO - 'LANGUAGE': 'en_US:en', 03:31:46 INFO - 'LOGNAME': 'cltbld', 03:31:46 INFO - 'MAIL': '/var/mail/cltbld', 03:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:46 INFO - 'MOZ_NO_REMOTE': '1', 03:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:46 INFO - 'NO_EM_RESTART': '1', 03:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:46 INFO - 'PWD': '/builds/slave/test', 03:31:46 INFO - 'SHELL': '/bin/bash', 03:31:46 INFO - 'SHLVL': '1', 03:31:46 INFO - 'TERM': 'linux', 03:31:46 INFO - 'TMOUT': '86400', 03:31:46 INFO - 'USER': 'cltbld', 03:31:46 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:46 INFO - '_': '/tools/buildbot/bin/python'} 03:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:46 INFO - Downloading/unpacking psutil>=0.7.1 03:31:46 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 03:31:46 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 03:31:46 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 03:31:46 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 03:31:46 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 03:31:46 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 03:31:48 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:31:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:48 INFO - Installing collected packages: psutil 03:31:48 INFO - Running setup.py install for psutil 03:31:48 INFO - building 'psutil._psutil_linux' extension 03:31:48 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 03:31:48 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 03:31:48 INFO - building 'psutil._psutil_posix' extension 03:31:48 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 03:31:48 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 03:31:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:49 INFO - Successfully installed psutil 03:31:49 INFO - Cleaning up... 03:31:49 INFO - Return code: 0 03:31:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:49 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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:31:49 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 03:31:49 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 03:31:49 INFO - Using env: {'DISPLAY': ':0', 03:31:49 INFO - 'HOME': '/home/cltbld', 03:31:49 INFO - 'LANG': 'en_US.UTF-8', 03:31:49 INFO - 'LANGUAGE': 'en_US:en', 03:31:49 INFO - 'LOGNAME': 'cltbld', 03:31:49 INFO - 'MAIL': '/var/mail/cltbld', 03:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:49 INFO - 'MOZ_NO_REMOTE': '1', 03:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:49 INFO - 'NO_EM_RESTART': '1', 03:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:49 INFO - 'PWD': '/builds/slave/test', 03:31:49 INFO - 'SHELL': '/bin/bash', 03:31:49 INFO - 'SHLVL': '1', 03:31:49 INFO - 'TERM': 'linux', 03:31:49 INFO - 'TMOUT': '86400', 03:31:49 INFO - 'USER': 'cltbld', 03:31:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:49 INFO - '_': '/tools/buildbot/bin/python'} 03:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:31:49 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 03:31:49 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 03:31:49 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 03:31:49 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 03:31:49 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 03:31:49 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 03:31:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:31:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:31:51 INFO - Installing collected packages: mozsystemmonitor 03:31:51 INFO - Running setup.py install for mozsystemmonitor 03:31:51 INFO - Successfully installed mozsystemmonitor 03:31:51 INFO - Cleaning up... 03:31:51 INFO - Return code: 0 03:31:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:31:51 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 03:31:51 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 03:31:51 INFO - Using env: {'DISPLAY': ':0', 03:31:51 INFO - 'HOME': '/home/cltbld', 03:31:51 INFO - 'LANG': 'en_US.UTF-8', 03:31:51 INFO - 'LANGUAGE': 'en_US:en', 03:31:51 INFO - 'LOGNAME': 'cltbld', 03:31:51 INFO - 'MAIL': '/var/mail/cltbld', 03:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:51 INFO - 'MOZ_NO_REMOTE': '1', 03:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:51 INFO - 'NO_EM_RESTART': '1', 03:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:51 INFO - 'PWD': '/builds/slave/test', 03:31:51 INFO - 'SHELL': '/bin/bash', 03:31:51 INFO - 'SHLVL': '1', 03:31:51 INFO - 'TERM': 'linux', 03:31:51 INFO - 'TMOUT': '86400', 03:31:51 INFO - 'USER': 'cltbld', 03:31:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:51 INFO - '_': '/tools/buildbot/bin/python'} 03:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:51 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 03:31:51 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 03:31:51 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 03:31:51 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 03:31:51 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 03:31:51 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 03:31:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 INFO - Downloading docopt-0.6.1.tar.gz 03:31:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:53 INFO - Running setup.py install for blobuploader 03:31:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:53 INFO - Running setup.py install for requests 03:31:54 INFO - Running setup.py install for docopt 03:31:54 INFO - Successfully installed blobuploader requests docopt 03:31:54 INFO - Cleaning up... 03:31:54 INFO - Return code: 0 03:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:54 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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:31:54 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 03:31:54 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 03:31:54 INFO - Using env: {'DISPLAY': ':0', 03:31:54 INFO - 'HOME': '/home/cltbld', 03:31:54 INFO - 'LANG': 'en_US.UTF-8', 03:31:54 INFO - 'LANGUAGE': 'en_US:en', 03:31:54 INFO - 'LOGNAME': 'cltbld', 03:31:54 INFO - 'MAIL': '/var/mail/cltbld', 03:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:54 INFO - 'MOZ_NO_REMOTE': '1', 03:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:54 INFO - 'NO_EM_RESTART': '1', 03:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:54 INFO - 'PWD': '/builds/slave/test', 03:31:54 INFO - 'SHELL': '/bin/bash', 03:31:54 INFO - 'SHLVL': '1', 03:31:54 INFO - 'TERM': 'linux', 03:31:54 INFO - 'TMOUT': '86400', 03:31:54 INFO - 'USER': 'cltbld', 03:31:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:54 INFO - '_': '/tools/buildbot/bin/python'} 03:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:54 INFO - Running setup.py (path:/tmp/pip-F4ZmDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:54 INFO - Running setup.py (path:/tmp/pip-IAtmdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:54 INFO - Running setup.py (path:/tmp/pip-66aGsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:54 INFO - Running setup.py (path:/tmp/pip-SZaQMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:54 INFO - Running setup.py (path:/tmp/pip-fbudsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:54 INFO - Running setup.py (path:/tmp/pip-eULhOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:55 INFO - Running setup.py (path:/tmp/pip-XFCGs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:55 INFO - Running setup.py (path:/tmp/pip-xLY7t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:55 INFO - Running setup.py (path:/tmp/pip-uB1bEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:55 INFO - Running setup.py (path:/tmp/pip-4h9_R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:55 INFO - Running setup.py (path:/tmp/pip-yDuGGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:55 INFO - Running setup.py (path:/tmp/pip-nYkeRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:55 INFO - Running setup.py (path:/tmp/pip-OApB3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:55 INFO - Running setup.py (path:/tmp/pip-UVkHAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:55 INFO - Running setup.py (path:/tmp/pip-GXQUcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:55 INFO - Running setup.py (path:/tmp/pip-Y7pGDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:55 INFO - Running setup.py (path:/tmp/pip-5HLOk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:55 INFO - Running setup.py install for manifestparser 03:31:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:55 INFO - Running setup.py install for mozcrash 03:31:56 INFO - Running setup.py install for mozdebug 03:31:56 INFO - Running setup.py install for mozdevice 03:31:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Running setup.py install for mozfile 03:31:56 INFO - Running setup.py install for mozhttpd 03:31:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Running setup.py install for mozinfo 03:31:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Running setup.py install for mozInstall 03:31:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Running setup.py install for mozleak 03:31:56 INFO - Running setup.py install for mozlog 03:31:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Running setup.py install for moznetwork 03:31:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Running setup.py install for mozprocess 03:31:57 INFO - Running setup.py install for mozprofile 03:31:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Running setup.py install for mozrunner 03:31:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Running setup.py install for mozscreenshot 03:31:57 INFO - Running setup.py install for moztest 03:31:57 INFO - Running setup.py install for mozversion 03:31:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:57 INFO - Cleaning up... 03:31:57 INFO - Return code: 0 03:31:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:31:57 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 03:31:57 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 03:31:57 INFO - Using env: {'DISPLAY': ':0', 03:31:57 INFO - 'HOME': '/home/cltbld', 03:31:57 INFO - 'LANG': 'en_US.UTF-8', 03:31:57 INFO - 'LANGUAGE': 'en_US:en', 03:31:57 INFO - 'LOGNAME': 'cltbld', 03:31:57 INFO - 'MAIL': '/var/mail/cltbld', 03:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:57 INFO - 'MOZ_NO_REMOTE': '1', 03:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:57 INFO - 'NO_EM_RESTART': '1', 03:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:57 INFO - 'PWD': '/builds/slave/test', 03:31:57 INFO - 'SHELL': '/bin/bash', 03:31:57 INFO - 'SHLVL': '1', 03:31:57 INFO - 'TERM': 'linux', 03:31:57 INFO - 'TMOUT': '86400', 03:31:57 INFO - 'USER': 'cltbld', 03:31:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:57 INFO - '_': '/tools/buildbot/bin/python'} 03:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:57 INFO - Running setup.py (path:/tmp/pip-8XM82a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:57 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)) 03:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:57 INFO - Running setup.py (path:/tmp/pip-XjC3OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:57 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)) 03:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:57 INFO - Running setup.py (path:/tmp/pip-S8kz6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:58 INFO - Running setup.py (path:/tmp/pip-QqsWZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:58 INFO - Running setup.py (path:/tmp/pip-ujRM6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:58 INFO - Running setup.py (path:/tmp/pip-h6jKCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:58 INFO - Running setup.py (path:/tmp/pip-zIrNg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:58 INFO - Running setup.py (path:/tmp/pip-_IF7D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:58 INFO - Running setup.py (path:/tmp/pip-XMNIsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:58 INFO - Running setup.py (path:/tmp/pip-rtPNLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:58 INFO - Running setup.py (path:/tmp/pip-nAo9Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:58 INFO - Running setup.py (path:/tmp/pip-wUSdzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:58 INFO - Running setup.py (path:/tmp/pip-yF8nyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:58 INFO - Running setup.py (path:/tmp/pip-G0fv4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:58 INFO - Running setup.py (path:/tmp/pip-xmEMkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:58 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)) 03:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:58 INFO - Running setup.py (path:/tmp/pip-Y0hz2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:59 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)) 03:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:59 INFO - Running setup.py (path:/tmp/pip-IctCTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:59 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)) 03:31:59 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)) 03:31:59 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)) 03:31:59 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)) 03:31:59 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)) 03:31:59 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)) 03:31:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:00 INFO - Downloading blessings-1.5.1.tar.gz 03:32:00 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 03:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:00 INFO - Installing collected packages: blessings 03:32:00 INFO - Running setup.py install for blessings 03:32:00 INFO - Successfully installed blessings 03:32:00 INFO - Cleaning up... 03:32:01 INFO - Return code: 0 03:32:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:01 INFO - Reading from file tmpfile_stdout 03:32:01 INFO - Current package versions: 03:32:01 INFO - argparse == 1.2.1 03:32:01 INFO - blessings == 1.5.1 03:32:01 INFO - blobuploader == 1.2.4 03:32:01 INFO - docopt == 0.6.1 03:32:01 INFO - manifestparser == 1.1 03:32:01 INFO - mozInstall == 1.12 03:32:01 INFO - mozcrash == 0.16 03:32:01 INFO - mozdebug == 0.1 03:32:01 INFO - mozdevice == 0.48 03:32:01 INFO - mozfile == 1.2 03:32:01 INFO - mozhttpd == 0.7 03:32:01 INFO - mozinfo == 0.9 03:32:01 INFO - mozleak == 0.1 03:32:01 INFO - mozlog == 3.1 03:32:01 INFO - moznetwork == 0.27 03:32:01 INFO - mozprocess == 0.22 03:32:01 INFO - mozprofile == 0.28 03:32:01 INFO - mozrunner == 6.11 03:32:01 INFO - mozscreenshot == 0.1 03:32:01 INFO - mozsystemmonitor == 0.0 03:32:01 INFO - moztest == 0.7 03:32:01 INFO - mozversion == 1.4 03:32:01 INFO - psutil == 3.1.1 03:32:01 INFO - requests == 1.2.3 03:32:01 INFO - wsgiref == 0.1.2 03:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:01 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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:32:01 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 03:32:01 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 03:32:01 INFO - Using env: {'DISPLAY': ':0', 03:32:01 INFO - 'HOME': '/home/cltbld', 03:32:01 INFO - 'LANG': 'en_US.UTF-8', 03:32:01 INFO - 'LANGUAGE': 'en_US:en', 03:32:01 INFO - 'LOGNAME': 'cltbld', 03:32:01 INFO - 'MAIL': '/var/mail/cltbld', 03:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:01 INFO - 'MOZ_NO_REMOTE': '1', 03:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:01 INFO - 'NO_EM_RESTART': '1', 03:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:01 INFO - 'PWD': '/builds/slave/test', 03:32:01 INFO - 'SHELL': '/bin/bash', 03:32:01 INFO - 'SHLVL': '1', 03:32:01 INFO - 'TERM': 'linux', 03:32:01 INFO - 'TMOUT': '86400', 03:32:01 INFO - 'USER': 'cltbld', 03:32:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:01 INFO - '_': '/tools/buildbot/bin/python'} 03:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 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)) 03:32:01 INFO - Cleaning up... 03:32:01 INFO - Return code: 0 03:32:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:01 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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:32:01 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 03:32:01 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 03:32:01 INFO - Using env: {'DISPLAY': ':0', 03:32:01 INFO - 'HOME': '/home/cltbld', 03:32:01 INFO - 'LANG': 'en_US.UTF-8', 03:32:01 INFO - 'LANGUAGE': 'en_US:en', 03:32:01 INFO - 'LOGNAME': 'cltbld', 03:32:01 INFO - 'MAIL': '/var/mail/cltbld', 03:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:01 INFO - 'MOZ_NO_REMOTE': '1', 03:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:01 INFO - 'NO_EM_RESTART': '1', 03:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:01 INFO - 'PWD': '/builds/slave/test', 03:32:01 INFO - 'SHELL': '/bin/bash', 03:32:01 INFO - 'SHLVL': '1', 03:32:01 INFO - 'TERM': 'linux', 03:32:01 INFO - 'TMOUT': '86400', 03:32:01 INFO - 'USER': 'cltbld', 03:32:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:01 INFO - '_': '/tools/buildbot/bin/python'} 03:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:01 INFO - Downloading/unpacking jsonschema 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:03 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 03:32:03 INFO - Downloading/unpacking functools32 (from jsonschema) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:03 INFO - warning: no files found matching '*.txt' 03:32:03 INFO - no previously-included directories found matching 'build' 03:32:03 INFO - no previously-included directories found matching 'dist' 03:32:03 INFO - no previously-included directories found matching '.git*' 03:32:03 INFO - Installing collected packages: jsonschema, functools32 03:32:03 INFO - Running setup.py install for functools32 03:32:03 INFO - warning: no files found matching '*.txt' 03:32:03 INFO - no previously-included directories found matching 'build' 03:32:03 INFO - no previously-included directories found matching 'dist' 03:32:03 INFO - no previously-included directories found matching '.git*' 03:32:03 INFO - Successfully installed jsonschema functools32 03:32:03 INFO - Cleaning up... 03:32:03 INFO - Return code: 0 03:32:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:32:03 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')]} 03:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 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')]} 03:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:03 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 0x7f590457cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, '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': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', '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 03:32:03 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 03:32: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 flake8 03:32:03 INFO - Using env: {'DISPLAY': ':0', 03:32:03 INFO - 'HOME': '/home/cltbld', 03:32:03 INFO - 'LANG': 'en_US.UTF-8', 03:32:03 INFO - 'LANGUAGE': 'en_US:en', 03:32:03 INFO - 'LOGNAME': 'cltbld', 03:32:03 INFO - 'MAIL': '/var/mail/cltbld', 03:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:03 INFO - 'MOZ_NO_REMOTE': '1', 03:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:03 INFO - 'NO_EM_RESTART': '1', 03:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:03 INFO - 'PWD': '/builds/slave/test', 03:32:03 INFO - 'SHELL': '/bin/bash', 03:32:03 INFO - 'SHLVL': '1', 03:32:03 INFO - 'TERM': 'linux', 03:32:03 INFO - 'TMOUT': '86400', 03:32:03 INFO - 'USER': 'cltbld', 03:32:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:03 INFO - '_': '/tools/buildbot/bin/python'} 03:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:04 INFO - Downloading/unpacking flake8 03:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:05 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 03:32:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:05 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 03:32:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:06 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 03:32:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:06 INFO - no previously-included directories found matching 'docs/_build' 03:32:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:06 INFO - Running setup.py install for pep8 03:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:06 INFO - no previously-included directories found matching 'docs/_build' 03:32:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:32:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:06 INFO - Cleaning up... 03:32:06 INFO - Return code: 0 03:32:06 INFO - Running post-action listener: _resource_record_post_action 03:32:06 INFO - Running post-action listener: _start_resource_monitoring 03:32:06 INFO - Starting resource monitoring. 03:32:06 INFO - ##### 03:32:06 INFO - ##### Running install step. 03:32:06 INFO - ##### 03:32:06 INFO - Running pre-action listener: _resource_record_pre_action 03:32:06 INFO - Running main action method: install 03:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:06 INFO - Reading from file tmpfile_stdout 03:32:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:06 INFO - Reading from file tmpfile_stdout 03:32:06 INFO - Output received: 03:32:06 INFO - Usage: mozinstall [options] installer 03:32:06 INFO - Options: 03:32:06 INFO - -h, --help show this help message and exit 03:32:06 INFO - -d DEST, --destination=DEST 03:32:06 INFO - Directory to install application into. [default: 03:32:06 INFO - "/builds/slave/test"] 03:32:06 INFO - --app=APP Application being installed. [default: firefox] 03:32:06 INFO - mkdir: /builds/slave/test/build/application 03:32:06 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'] 03:32:06 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 03:32:22 INFO - Reading from file tmpfile_stdout 03:32:22 INFO - Output received: 03:32:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:22 INFO - Running post-action listener: _resource_record_post_action 03:32:22 INFO - ##### 03:32:22 INFO - ##### Running run-tests step. 03:32:22 INFO - ##### 03:32:22 INFO - Running pre-action listener: _resource_record_pre_action 03:32:22 INFO - Running main action method: run_tests 03:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:22 INFO - Python 2.7.3 03:32:22 INFO - Return code: 0 03:32:22 INFO - grabbing minidump binary from tooltool 03:32:22 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')]} 03:32:22 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 0xf5a3d0>, '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 0xec5ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec6360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:22 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 03:32:22 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 03:32:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:22 INFO - Return code: 0 03:32:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:23 INFO - Return code: 0 03:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:32:23 INFO - Using env: {'DISPLAY': ':0', 03:32:23 INFO - 'HOME': '/home/cltbld', 03:32:23 INFO - 'LANG': 'en_US.UTF-8', 03:32:23 INFO - 'LANGUAGE': 'en_US:en', 03:32:23 INFO - 'LOGNAME': 'cltbld', 03:32:23 INFO - 'MAIL': '/var/mail/cltbld', 03:32:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:23 INFO - 'MOZ_NO_REMOTE': '1', 03:32:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:23 INFO - 'NO_EM_RESTART': '1', 03:32:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:23 INFO - 'PWD': '/builds/slave/test', 03:32:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:23 INFO - 'SHELL': '/bin/bash', 03:32:23 INFO - 'SHLVL': '1', 03:32:23 INFO - 'TERM': 'linux', 03:32:23 INFO - 'TMOUT': '86400', 03:32:23 INFO - 'USER': 'cltbld', 03:32:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030', 03:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:23 INFO - '_': '/tools/buildbot/bin/python'} 03:32:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:32:23 INFO - mozversion application_buildid: 20160115023944 03:32:23 INFO - mozversion application_changeset: 4c92836f188be7490401084802dd7c21ba75334a 03:32:23 INFO - mozversion application_display_name: Nightly 03:32:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:23 INFO - mozversion application_name: Firefox 03:32:23 INFO - mozversion application_remotingname: firefox 03:32:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:32:23 INFO - mozversion application_vendor: Mozilla 03:32:23 INFO - mozversion application_version: 46.0a1 03:32:23 INFO - mozversion platform_buildid: 20160115023944 03:32:23 INFO - mozversion platform_changeset: 4c92836f188be7490401084802dd7c21ba75334a 03:32:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:32:23 INFO - mozversion platform_version: 46.0a1 03:32:23 INFO - using testdate: 1452857543 03:32:23 INFO - actual date: 1452857543 03:32:23 INFO - starting webserver on 'localhost:59456' 03:32:23 INFO - SUITE-START | Running 3 tests 03:32:23 INFO - TEST-START | dromaeo_css 03:32:23 INFO - operating with platform_type : linux_ 03:32:23 INFO - Initialising browser for dromaeo_css test... 03:32:23 INFO - TEST-INFO | started process 27219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoMIvoT/profile http://localhost:59456/getInfo.html) 03:32:28 INFO - PROCESS | 27219 | 03:32:28 INFO - PROCESS | 27219 | (process:27304): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:28 INFO - PROCESS | 27219 | __metrics Screen width/height:1600/1200 03:32:28 INFO - PROCESS | 27219 | colorDepth:24 03:32:28 INFO - PROCESS | 27219 | Browser inner width/height: 1024/697 03:32:28 INFO - PROCESS | 27219 | __metrics 03:32:28 INFO - PROCESS | 27219 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:32:29 INFO - TEST-INFO | 27219: exit 0 03:32:29 INFO - Browser initialized. 03:32:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:29 INFO - TEST-INFO | started process 27353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoMIvoT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:31 INFO - PROCESS | 27353 | 03:32:31 INFO - PROCESS | 27353 | (process:27412): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:41 INFO - PROCESS | 27353 | RSS: Main: 150605824 03:32:41 INFO - PROCESS | 27353 | 03:33:31 INFO - PROCESS | 27353 | 1452857611595 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] 03:35:41 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:59456/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59456/tests/dromaeo/cssquery-ext.html) 03:35:42 INFO - PROCESS | 27353 | RSS: Main: 155193344 03:35:42 INFO - PROCESS | 27353 | 03:38:45 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:59456/tests/dromaeo/cssquery-ext.html (next: http://localhost:59456/tests/dromaeo/cssquery-jquery.html) 03:38:45 INFO - PROCESS | 27353 | RSS: Main: 150482944 03:38:45 INFO - PROCESS | 27353 | 03:41:47 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:59456/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59456/tests/dromaeo/cssquery-mootools.html) 03:41:48 INFO - PROCESS | 27353 | RSS: Main: 150978560 03:41:48 INFO - PROCESS | 27353 | 03:44:49 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:59456/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59456/tests/dromaeo/cssquery-prototype.html) 03:44:50 INFO - PROCESS | 27353 | RSS: Main: 150413312 03:44:50 INFO - PROCESS | 27353 | 03:47:53 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:59456/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59456/tests/dromaeo/cssquery-yui.html) 03:47:53 INFO - PROCESS | 27353 | RSS: Main: 150515712 03:47:53 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:59456/tests/dromaeo/cssquery-yui.html (next: http://localhost:59456/tests/dromaeo/cssquery-dojo.html) 03:50:56 INFO - PROCESS | 27353 | RSS: Main: 153305088 03:50:56 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | __start_tp_report 03:50:56 INFO - PROCESS | 27353 | _x_x_mozilla_page_load 03:50:56 INFO - PROCESS | 27353 | _x_x_mozilla_page_load_details 03:50:56 INFO - PROCESS | 27353 | |i|pagename|runs| 03:50:56 INFO - PROCESS | 27353 | |0;dojo.html;2616.123598594471;2684.5302072137397;2714.457108578285;2718.7281271872816;2731.1260396673065;4455.821767129319;4603.079384123176;4620.330052142442;4636.211843986522;4641.5590518900735;4503;4512.887177820556;4514.1423129605355;4524.004718961832;4576.5652263035045;14.169744795898815;4223.493180818306;4229.794508565052;4280.3151495760685;4327.6754243431715;4045.1505183911413;4196.139791342767;4247.87256382309;4273.850415235467;4284.078923031548;4218.936715949248;4247.575242475758;4255.340422234559;4285.292926667112;4292.892677683051;4210.536840947493;4220.725652832556;4229.111886503838;4260.723053001576;4262.978685106555;4128.8348466061325;4140.047789008515;4206.26390381682;4239.894002649928;4255.744655320691;4471.731696098212;4473.82104715811;4498;4505.662075344362;4526.094781043805;4864.270359446076;4871.14754917888;4880.121578115938;4892;4936.728479933602;4795.376601041842;4907.288443175719;4917.4344950330815;4969.950300497021;4990.201567749179;4580.129775342708;4597.057603191338;4603.8158473661015;4606.516315786861;4626.8149274029;4934.605231581465;5035.0685123252315;5041.2438134280155;5057.190849464068;5093.1087059764395;4777.8327758528285;4805.37530121082;4810.975945120252;4819.6867203631655;4855.757212139379;4933.925991110136;4960.90078198434;4966.329545511309;4973.030259099513;5014.89970200594;4751.239801631791;4849.248366503198;4871.780769865364;4896.853094407174;4945.7774400152075;4828.975855120702;4851.223804191312;4871.34236878017;4887.486813884562;4893.4617192108835;4033.3143365627916;4045.3931910213705;4062.5531191568903;4071;4082.4692789937117;3514.7715398499017;3553.982230088833;3575.1598374382;3623.311570801592;3630;4236.216299984513;4255.957440425618;4266.338717498793;4294.849680261176;4307;4873.658843880894;4905.2151655734915;4907.460179380265;4909.140900342426;4941.802327906844;4212.431321771522;4229.471316085489;4259.574042595777;4298.140371925628;4317.266064768997;4347.282698354799;4355.891102722458;4379.934300985487;4380.934285985712;4410.845620403271;4623.815047398134;4646.210144275481;4662.883427914194;4681.087187998308;4715.764211789466;4740.857774266778;4777.4505931818285;4810.4467986182035;4837.709737415626;4847.248676455155;4605.861824145281;4623.16782979067;4633.096546173464;4637.118947399983;4638.489766125791;4763.356946812136;4823.2282834746275;4835.371401717754;4862.635302352409;4878.9512104878495;4843.6367272454;4874.926876096791;4911.8280860169725;4912.189488734319;4916.606671466203;4774.4509381421585;4818.68678535894;4823.927641085316;4826.541478559531;4842.9757851211925;4629.097326021528;4736.928946065881;4775.928361074517;4789;4833.73414462208;4663.487016428258;4686.437627484587;4731.479537250969;4731.787069581808;4781.9043619128115;4731.645126615449;4754.144254034307;4762.190427627243;4782.928256076092;4793.952060479351;4588.334691469651;4652.813887444464;4668.533146685304;4676.742779147179;4687.953120468752 03:50:56 INFO - PROCESS | 27353 | |1;ext.html;505.2572718104387;517.4489169034975;522.1801771219185;532.5393534592578;559.8404454730403;32677.50983735246;33691;33714.49428258572;33736.15659608508;33808.830955845246;37039.4444083339;37544;37568.43647345292;37586.43620345697;37638.247235055285;7630.4658673892845;7814.76555703327;7826.72606458774;7840.490368126082;7842;7594.126675432341;7669.194734552875;7690.846183076335;7694.846103077935;7710.498817576868;7837.451378403514;7890.447668663196;7895.092064412609;7922.881156782624;7935.603219839014;7814.6092695365005;7878.212178782133;7902.841943161162;7913.287804097658;7931.722389716361;7678.424118191158;7737.264959828807;7742.070951485802;7796.337311328544;7831.060272767304;37004.44493332602;37581.81209093937;37668;37677.43483847744;37684.43473347902;2464.778169964694;2943.936429341529;2982.925426864346;3129.5775070365435;3146.4179126861377;23970.400739981465;28032;28956.42087158266;29076.27309317263;29257.853710731524;3430.091025878144;3440.569928758905;3448.6551344865566;3496.213351995806;3513.350030244387;180207;181246;181665.37509686826;182247;182287.99999999866;46798.76600617043;48091.519084809406;50110.49889501131;51750.74124629428;52095.73952130215;58977;59358.703206484555;60355.396446034974;60509.69745151246;60702.39297607056;13711.314434278247;13847;13868.722625547432;13922.234277114856;13950.232737199349;10954.123670106372;10960.56157753681;11015.173861960226;11085.83371249432;11127.833082503768;18368.265269389343;18977.24091036343;19042.80957190438;19046.714299285522;19068;7478.177400485943;7727.1886451922865;7727.624709614591;7732.149463559004;7839.764807055797;883.1301168349171;893.4103491695449;945.3713280668278;969.4619486185235;997.81540415022;27156.45687086287;27313.044043458383;27410.314742131606;27436.45127097447;27454.725452745617;962.1436921140191;986.7977064701719;997.2271489595477;1004.091297375876;1065.3980501016902;13684.589462316146;13832.30838458073;13843.377048032862;14033.438662453591;14309.499167529295;290523;299982;300240;301417;301911;47109.76445117752;47857.521424786006;48062;48113.278300825514;48119.75940120277;1257.735875466144;1291.0575280045432;1297.9221246725226;1303.7066660001424;1305.1907817153426;25673.614895776205;26002.739972600033;26111;26181.214563563124;26308;39202.80398597989;40045.59954400419;40146.1970760589;40233.39649905195;40255.798721006206;238093;238586;238718;239036;239790;29515.40969180647;32090;32896.50655240125;39419.2116157681;41384.172316554104;35066;38300;38864.80567597144;38985.41521877231;39264.05519585985;32395.35209295848;32398.35203295968;32690.50964235586;33465.83267083649;34083.65916340805;33291.334173316885;34438.48342274918;36544.26911461809;39102.413463798635;39783.80108099441;33196;33333;33437.83281083579;33452;33461.16347091342;25502.744972550037;25667;25726.485470290114;26716.19851404461;31758.364832702755;18268.72596911074;18334;18374.35689750852;18409.90795046016;18419.53951151232 03:50:56 INFO - PROCESS | 27353 | |2;jquery.html;339.8674516938394;342.66076584181656;344.1636822521274;346.8092549097996;350.4515433346814;14713.70572588549;14786.18675972821;15015.249237538133;15634.84365156348;16301.184940752973;14691.191984440851;14781.556553303391;14937.775933361008;15113.622159445991;15117.622059448518;4566.223741963874;4937;5143.897122057557;5145.691258524482;5145.691258524501;5051.9494805051845;5070.569001634847;5077.162268225738;5096.796128154888;5444.183372494138;4990.925136122961;5218.1650935850275;5223.085959956992;5749.166370876242;5771.653700777946;5108.182690769459;5136.383633963929;5154.329937108152;5165.35433070868;5185.066687996159;5971.28344598651;6241.407066328691;6255.186825712628;6269.090981807658;6287.088372186053;17930.462086137435;18584.256629734795;19180.71228931567;19280.4215873524;20838.5832283355;1963.2539634938776;1972.8323092537153;1975.6345076160812;2038.175832629803;2121.893905304744;13225.470981160743;13278.07053506255;13358.732825343439;13493.392797324144;13823.79264311036;1796.1378538301688;1799.640071985608;1871.4759867237196;1887.5658598522416;1936.2738972885168;54377;55658.44341556573;56754;57940.42059579435;58463.415365846224;14661.413543458142;14668.311910197603;14683.55949321522;14746.336414861142;15191.468298609496;21868.78131218699;21874.453138671342;21881.452963676034;21960.780392195873;21988.450288742908;8400.579971001425;8436.873446898302;8441.451305665112;8468.830623387497;8501.06488286288;7101.076860008269;7120.608366539786;7157.1769246537315;7159.821004474826;7204.711811527585;7217.278272172845;7275.490715649854;7333.339999400079;7371.373433258126;7387.187409384964;2842.8862845486365;2944.9263768405963;2954.1580649514785;2974.925626859346;3056.205386599456;397.2928187825675;402.1895879802201;417.4677286459788;418.4016855896037;432.112009819817;14293.213873237071;15511.922440387725;15557.29992150356;15840;16155.919220403823;862.6808081010066;883.9204471597587;901.7384958362132;924.2513564013171;927.5408672707053;8871.423357481743;8936.910630893608;8938.24024957886;9008.009118996904;9107.908920910839;416729;426973;429343;431772;432543;38963.662180269275;40483;55636.443635563126;61906.69046654828;64684;1106.8450416941473;1111.8221084626582;1122.7754449110212;1129.9039581635652;1132.116948779953;12672.746545068863;13190.406431710788;13711.657208569866;13815.240161791198;14052.718945621235;26891.865540672956;27369.17892463229;27952.58071128894;28359.716402836533;28522.144335669964;32056.83971580127;32670.673293266762;32812.343753124325;32967.83516082404;32971.340573188885;6642.701078451578;6681.599104053578;6720.025596288413;6782.118324617768;6823.4882383822405;9009.324300677607;9946.254030947852;10061.245406594388;10226.437545935045;10385.792284154426;8446.450980686235;8647.01421044239;8825.646974120964;8949.239314658067;9016.549172541478;6696.665166741741;8869.201771840566;9094.363394562582;9173.35786494939;9539.284553658365;2824.844633545175;2842.3178437175343;9360.95319523398;9439.820022497188;9503.097205765442;6515.543911926309;6581.934180658323;6623.569467984566;6658;6776.28848970851;8942.50816205115;9098;9437.245020398213;9509.572069256761;9553.904460955302 03:50:56 INFO - PROCESS | 27353 | |3;mootools.html;1374.168627980072;1389.8332200135983;1503.54141986694;1699.5581148901283;1714.8799584029107;6122.785702500413;6206.596571222867;6946.756863509778;7212.278772122791;7212.56724596524;6735.124433823608;6850.417714494261;6929.584224946494;6946.861062778741;6959.5476294040855;2106.7682554918983;2134.551744133734;2134.8505604607685;2136.3484137338182;2137.7862213778576;2157.622416077188;2179.7602263750973;2182.3452964110784;2182.3998400439846;2182.9454263643456;2149.570085982802;2164.047818959653;2168.7072245246845;2179.4333473296897;2192.5176461178594;2173.4240426287124;2176.09691977829;2181.879996600186;2182.23621732394;2184.2682701295084;2100.653392190287;2136.316378758798;2138.1661152150673;2139.775323591032;2139.9465013374634;7264;7312.195658477616;7315;7317.0487836580905;7332.8900066499045;4256.106217694288;4325.221460137174;4347;4390.297552391634;4392.604665580113;2748.051922086877;2789.916302510928;2820.0411859967503;2824.61867647867;2826.434713057397;863.1282404771226;897.4301318662631;898.8606765951288;899.5277479323343;922.1654402765508;9853.556589953469;9869.703908882744;9872.407655540619;9877.654282100091;9916.157126644172;4049.8582549610624;4096.877093687194;4108.958910410917;4172.08214192877;4194.748315101104;8353;8362.289205417486;8365.330773538102;8438.789030274293;8454.196851299117;4386.254336762758;4405.207062728739;4413.668974826901;4419.64642828573;4461.174682683714;3417.8974630761118;3480.89557313281;3848.461215429842;4018.136100738297;4037.9394309085387;3508.614052454228;3519.1202199450136;3547.201879577126;3564.697000754913;3604.116991337139;1083.101026148295;1094.885037071112;1124.173732306754;1125.662301309604;1130.7229728716518;1106.983395249072;1115.1859142825783;1134.5972179876026;1137.766757814646;1145.7135716070982;6399.9040014399825;6437.452816510649;6454.806355809334;6459.61242325462;6474.1907261592305;411.04842290098924;411.05047340642614;413.19427117121734;414.44878311845173;414.72420840140967;4947.82682606107;4949.678270912451;4989.3264409305;5004.524570165829;5030.547250747451;8546.871796923051;8848.247898928663;8854.557272136497;8863.867041994376;8950.328725345626;8630.136986301319;8652.134786521423;8728.607212675444;8731.825363492695;8770.868436973451;6598.307177746364;6814.795556133324;6858.725650974005;6890.621015844176;6906.723731050803;6224.2842073160355;6230.563860529719;6234.220722409699;6239.251289845248;6257.624542527463;7712.884306735291;7756.650950707119;7811.804704882424;7821;7893.960530197312;7888.960555197187;8099.797505062421;8104.837903241784;8131.715389961323;8219.83560328802;6045.425684559959;6151.32335443092;6217.253929528486;6243.282022567463;6306.306306306211;6273.309935906956;6294.0558916162945;6309.652969086745;6309.684515774285;6310.368963103837;6130.662813545119;6191.504679625709;6199;6218.19163508741;6230.252369715663;6173.629582224901;6202.162708034358;6203.348648392034;6243.656598887105;6291.465225455888;6243.094751260951;6260.373962603703;6282.120503129657;6283.5601507895835;6304.338044505261;5871.383504731942;5875.794347197828;5892.057270836645;5911;5931.021381472009;5879.970600147143;6068.514518838394;6089.086637004308;6103.11504831788;6114 03:50:56 INFO - PROCESS | 27353 | |4;prototype.html;307.53869196205693;319.6739325887594;322.46470858375085;330.5702586637371;332.5776264144535;5439.102548079567;5520.5307548858345;5552.86117847053;5564.9999999999945;5707.5148612368;5460.890782184354;5485.807996720116;5505.146702261146;5506.862328441791;5509.090999985007;4132.917341653165;4209.705320627558;4215.810288537008;4229.36559516072;4242.172776308621;4205.453291072172;4207.705460617758;4223.838444427792;4234.513031001428;4239;4152.97923510382;4175.749455032693;4180.975660963069;4190.727602705814;4194.769287689176;4168;4179.853705120321;4180.205760905449;4187.958120418787;4197.9370309445385;3635.3456377851976;3641.198936234024;3650.5254316938895;3650.7261955353188;3651.087228192952;5167.3282473278605;5277.894442111136;5279.260903473517;5290.153575427951;5299.947000530023;4830.178869592178;4833.540813622701;4842.055799119174;4849.563539281482;4849.830255941025;5728.828135155952;5729.541636669056;5730.570207234474;5745.109508026221;5746.080627099685;3973.860914867995;3976.363781794899;3979.0251388410024;3979.900502487432;3981.661558767479;5785.62393444429;6016.548758843061;6022.728977196037;6031.2159419276095;6039.245094363205;4115.58844115592;4127.071408933026;4134.111166099243;4136.358864375967;4154.231467178522;4161.9375709364385;4187.560306167808;4203.4115223868685;4203.684723645739;4210.7684077375425;4825.541573550507;4826.710397376169;4828.686135401188;4833.275008748716;4847.660663753503;5625.128105143709;5713.971430142906;5744.167095771089;5750.25246717924;5755.453231942959;1460.167704408477;1487.0408586461888;1490.5453836579948;1490.5528341497507;1496.5585152380074;981.6367943860674;984.9953047891111;990.2276224544867;996.2378780233128;1001.1240164855751;5029.346184995927;5032.446430892599;5033.320501732219;5036.697798132123;5045.041442125985;5779.335376431764;5841.7371218295275;5963.224780778558;5970.402959703995;6076.392360763888;5060.51925067118;5097.515736005073;5097.719625420637;5107.438181799999;5107.7446127693465;3216.437123503424;3229.2088438332758;3229.434848901433;3248.0742988248235;3257.2019855135645;5484.972575137099;5605.159226116115;5646.830595082154;5651.0675738503505;5660.377358490563;6236.6258024518675;6238.563300568917;6247.250329960434;6248.4688801452385;6269.592476489013;5681.857953551194;5694.487496125285;5698.031334673115;5701.914471282934;5702.315722113373;6042.637441753509;6061.1514387984835;6068.605540639845;6072.939270607238;6074.969625151846;5766.855828604318;5893.939090963668;5914.792982245601;5917.053271476543;5921.3190483094995;5624.7187640616985;5661.179129026351;5665.716714164358;5677.148427735708;5687;4117.114820313647;4166.7708276045105;4167.041580436456;4171;4176.686748493815;5789.305283366023;5994.160817485468;6069.423404776539;6072.635641861326;6130.41761032719;5802.6808525531505;5825.3883342248455;5830.7959221427045;5833.095870140135;5854.180414742024;5778;5805.680687562224;5830.941690583039;5847.766089356378;5849.327327357409;5604.510752956505;5628.212050313042;5675.716214189357;5707.4577915098;5718.571107166896;5826.067829147316;5836.212111365081;5845.152452894392;5854.912176317273;5869.94130058711;5581.469760372758;5665.886682266249;5682.602217844711;5708.115242137475;5722.570807189561 03:50:56 INFO - PROCESS | 27353 | |5;yui.html;645.4932877691012;717.4521988765556;734.0274136768776;737.6016950846544;742.3986570877589;10386.584536618526;10616.309939853903;11798.174127811057;11969.76060478791;11989.580364687237;11733.178677492579;12085.697857553565;12103.636890893287;12113.273203607767;12124.69688257794;771.1748429180778;781.3944193250248;783.1307248953657;789.6841263494591;790.0124843945068;762.6225018615793;767.0986590755867;768.4313607930147;773.0645918438668;776.3633820267383;810.6919370639179;813.0649752784286;813.3899575318511;819.4304958054155;819.7950512371907;808.2564041082219;811.975640730779;812.4556547113418;812.5652775764937;814.6578437056451;597.6354423801478;602.9035354343328;603.2429301226932;603.4629180029777;604.5103466192398;11548.53805847765;12059.819102713467;12334.568290109803;12365.752684946341;12371.690707732289;11639.76720465586;11844.703882402922;11939;11954;12369.319687417188;9514.238860891111;9648.75878103046;9650.324477286593;9659.90340096597;9710.223182145412;4068.65416439603;4129.731567448106;4140.896477588084;4148.688848336386;4285.592868677501;40486.59513404858;40594;40798;40916;41165.38251926223;9484.95257523708;9550.092741189575;9565.091316324939;9576.425414475154;9925.950370248103;16612.08633525168;16717.49847504577;16744;16749.665006699797;16800.495985120466;6712.765053223211;6810.965945170342;6836.384725374641;6841.589504629738;6964.338387853146;3605.3149901518627;3634;3640.927181456409;3703.2778608171147;3746.063484128968;2547.3886267295716;2563.910263140781;2564.8974041038523;2570.974290257111;2574.034736973635;472.8983268597268;479.7673128532659;484.7745798203852;486.1007136796968;491.31461611053095;463.07154155917846;464.86518909516536;477.59404506169477;519.0708631549484;579.2990481517327;8688.174623410765;8730.38887277897;8810.207081362709;8815.471071735716;8889.511076890703;546.9042917489423;574.9597528172987;580.077676494376;610.88087822875;627.5011365964069;3626.801887680059;3709.870154544578;3761.5298087739034;4028.4964379452567;4040.1919616076902;39705.60294397019;40127.59872401297;40537.79731101326;40589.79705101515;40706.592934070875;37665.81167094202;37816.43275350872;38266.23467530634;40834.38748418776;40992.79503602463;36676.63323366785;37014.25971480555;37039.629603704154;37218.81390593084;37572.81213593969;8267.131951145044;8312.21034001769;8394.748157555283;8428.620712068094;8582.270507006975;28720.281992950342;29131.41737165287;29171;29390.265243369086;29430.411391771617;33842.32315353728;35919;36056;36225.818870905474;36600.45099323459;10031.247656425652;10109.19126469866;10176;10234.948825255826;10562.419066951392;10659.09397701204;11014.504347304552;11095.223334366518;11223.775524489627;11273.323600583992;10521.263511554118;10631.787364252827;10722.839157412802;10932.726681833017;11187.496562654538;10551.472426378497;10581.62438882971;10759.838602420814;10971.286866353661;11256.268342557707;10718.410487423267;10783.514741836792;10802.567897284021;10809.56761729522;10827.458627068458;8871.64513419456;8976.102389760972;9152.542372881197;9155.450672959643;9221.262299016196;9133.908660913572;9158.40470369424;9219.76950576241;9322.627094916399;9407.388519746195 03:50:56 INFO - PROCESS | 27353 | __end_tp_report 03:50:56 INFO - PROCESS | 27353 | __start_cc_report 03:50:56 INFO - PROCESS | 27353 | _x_x_mozilla_cycle_collect,331 03:50:56 INFO - PROCESS | 27353 | __end_cc_report 03:50:56 INFO - PROCESS | 27353 | __startTimestamp1452858656404__endTimestamp 03:50:56 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | ------- Summary: start ------- 03:50:56 INFO - PROCESS | 27353 | Number of tests: 6 03:50:56 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | [#0] dojo.html Cycles:165 Average:4501.83 Median:4641.56 stddev:577.61 (12.4%) stddev-sans-first:560.12 03:50:56 INFO - PROCESS | 27353 | Values: 2616.1 2684.5 2714.5 2718.7 2731.1 4455.8 4603.1 4620.3 4636.2 4641.6 4503.0 4512.9 4514.1 4524.0 4576.6 14.2 4223.5 4229.8 4280.3 4327.7 4045.2 4196.1 4247.9 4273.9 4284.1 4218.9 4247.6 4255.3 4285.3 4292.9 4210.5 4220.7 4229.1 4260.7 4263.0 4128.8 4140.0 4206.3 4239.9 4255.7 4471.7 4473.8 4498.0 4505.7 4526.1 4864.3 4871.1 4880.1 4892.0 4936.7 4795.4 4907.3 4917.4 4970.0 4990.2 4580.1 4597.1 4603.8 4606.5 4626.8 4934.6 5035.1 5041.2 5057.2 5093.1 4777.8 4805.4 4811.0 4819.7 4855.8 4933.9 4960.9 4966.3 4973.0 5014.9 4751.2 4849.2 4871.8 4896.9 4945.8 4829.0 4851.2 4871.3 4887.5 4893.5 4033.3 4045.4 4062.6 4071.0 4082.5 3514.8 3554.0 3575.2 3623.3 3630.0 4236.2 4256.0 4266.3 4294.8 4307.0 4873.7 4905.2 4907.5 4909.1 4941.8 4212.4 4229.5 4259.6 4298.1 4317.3 4347.3 4355.9 4379.9 4380.9 4410.8 4623.8 4646.2 4662.9 4681.1 4715.8 4740.9 4777.5 4810.4 4837.7 4847.2 4605.9 4623.2 4633.1 4637.1 4638.5 4763.4 4823.2 4835.4 4862.6 4879.0 4843.6 4874.9 4911.8 4912.2 4916.6 4774.5 4818.7 4823.9 4826.5 4843.0 4629.1 4736.9 4775.9 4789.0 4833.7 4663.5 4686.4 4731.5 4731.8 4781.9 4731.6 4754.1 4762.2 4782.9 4794.0 4588.3 4652.8 4668.5 4676.7 4688.0 03:50:56 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | [#1] ext.html Cycles:180 Average:40076.74 Median:18756.88 stddev:63901.21 (340.7%) stddev-sans-first:64011.39 03:50:56 INFO - PROCESS | 27353 | Values: 505.3 517.4 522.2 532.5 559.8 32677.5 33691.0 33714.5 33736.2 33808.8 37039.4 37544.0 37568.4 37586.4 37638.2 7630.5 7814.8 7826.7 7840.5 7842.0 7594.1 7669.2 7690.8 7694.8 7710.5 7837.5 7890.4 7895.1 7922.9 7935.6 7814.6 7878.2 7902.8 7913.3 7931.7 7678.4 7737.3 7742.1 7796.3 7831.1 37004.4 37581.8 37668.0 37677.4 37684.4 2464.8 2943.9 2982.9 3129.6 3146.4 23970.4 28032.0 28956.4 29076.3 29257.9 3430.1 3440.6 3448.7 3496.2 3513.4 180207.0 181246.0 181665.4 182247.0 182288.0 46798.8 48091.5 50110.5 51750.7 52095.7 58977.0 59358.7 60355.4 60509.7 60702.4 13711.3 13847.0 13868.7 13922.2 13950.2 10954.1 10960.6 11015.2 11085.8 11127.8 18368.3 18977.2 19042.8 19046.7 19068.0 7478.2 7727.2 7727.6 7732.1 7839.8 883.1 893.4 945.4 969.5 997.8 27156.5 27313.0 27410.3 27436.5 27454.7 962.1 986.8 997.2 1004.1 1065.4 13684.6 13832.3 13843.4 14033.4 14309.5 290523.0 299982.0 300240.0 301417.0 301911.0 47109.8 47857.5 48062.0 48113.3 48119.8 1257.7 1291.1 1297.9 1303.7 1305.2 25673.6 26002.7 26111.0 26181.2 26308.0 39202.8 40045.6 40146.2 40233.4 40255.8 238093.0 238586.0 238718.0 239036.0 239790.0 29515.4 32090.0 32896.5 39419.2 41384.2 35066.0 38300.0 38864.8 38985.4 39264.1 32395.4 32398.4 32690.5 33465.8 34083.7 33291.3 34438.5 36544.3 39102.4 39783.8 33196.0 33333.0 33437.8 33452.0 33461.2 25502.7 25667.0 25726.5 26716.2 31758.4 18268.7 18334.0 18374.4 18409.9 18419.5 03:50:56 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | [#2] jquery.html Cycles:180 Average:23629.42 Median:216487.56 stddev:69636.74 (32.2%) stddev-sans-first:69810.13 03:50:56 INFO - PROCESS | 27353 | Values: 339.9 342.7 344.2 346.8 350.5 14713.7 14786.2 15015.2 15634.8 16301.2 14691.2 14781.6 14937.8 15113.6 15117.6 4566.2 4937.0 5143.9 5145.7 5145.7 5051.9 5070.6 5077.2 5096.8 5444.2 4990.9 5218.2 5223.1 5749.2 5771.7 5108.2 5136.4 5154.3 5165.4 5185.1 5971.3 6241.4 6255.2 6269.1 6287.1 17930.5 18584.3 19180.7 19280.4 20838.6 1963.3 1972.8 1975.6 2038.2 2121.9 13225.5 13278.1 13358.7 13493.4 13823.8 1796.1 1799.6 1871.5 1887.6 1936.3 54377.0 55658.4 56754.0 57940.4 58463.4 14661.4 14668.3 14683.6 14746.3 15191.5 21868.8 21874.5 21881.5 21960.8 21988.5 8400.6 8436.9 8441.5 8468.8 8501.1 7101.1 7120.6 7157.2 7159.8 7204.7 7217.3 7275.5 7333.3 7371.4 7387.2 2842.9 2944.9 2954.2 2974.9 3056.2 397.3 402.2 417.5 418.4 432.1 14293.2 15511.9 15557.3 15840.0 16155.9 862.7 883.9 901.7 924.3 927.5 8871.4 8936.9 8938.2 9008.0 9107.9 416729.0 426973.0 429343.0 431772.0 432543.0 38963.7 40483.0 55636.4 61906.7 64684.0 1106.8 1111.8 1122.8 1129.9 1132.1 12672.7 13190.4 13711.7 13815.2 14052.7 26891.9 27369.2 27952.6 28359.7 28522.1 32056.8 32670.7 32812.3 32967.8 32971.3 6642.7 6681.6 6720.0 6782.1 6823.5 9009.3 9946.3 10061.2 10226.4 10385.8 8446.5 8647.0 8825.6 8949.2 9016.5 6696.7 8869.2 9094.4 9173.4 9539.3 2824.8 2842.3 9361.0 9439.8 9503.1 6515.5 6581.9 6623.6 6658.0 6776.3 8942.5 9098.0 9437.2 9509.6 9553.9 03:50:56 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | [#3] mootools.html Cycles:180 Average:4974.71 Median:6118.39 stddev:2589.80 (42.3%) stddev-sans-first:2582.92 03:50:56 INFO - PROCESS | 27353 | Values: 1374.2 1389.8 1503.5 1699.6 1714.9 6122.8 6206.6 6946.8 7212.3 7212.6 6735.1 6850.4 6929.6 6946.9 6959.5 2106.8 2134.6 2134.9 2136.3 2137.8 2157.6 2179.8 2182.3 2182.4 2182.9 2149.6 2164.0 2168.7 2179.4 2192.5 2173.4 2176.1 2181.9 2182.2 2184.3 2100.7 2136.3 2138.2 2139.8 2139.9 7264.0 7312.2 7315.0 7317.0 7332.9 4256.1 4325.2 4347.0 4390.3 4392.6 2748.1 2789.9 2820.0 2824.6 2826.4 863.1 897.4 898.9 899.5 922.2 9853.6 9869.7 9872.4 9877.7 9916.2 4049.9 4096.9 4109.0 4172.1 4194.7 8353.0 8362.3 8365.3 8438.8 8454.2 4386.3 4405.2 4413.7 4419.6 4461.2 3417.9 3480.9 3848.5 4018.1 4037.9 3508.6 3519.1 3547.2 3564.7 3604.1 1083.1 1094.9 1124.2 1125.7 1130.7 1107.0 1115.2 1134.6 1137.8 1145.7 6399.9 6437.5 6454.8 6459.6 6474.2 411.0 411.1 413.2 414.4 414.7 4947.8 4949.7 4989.3 5004.5 5030.5 8546.9 8848.2 8854.6 8863.9 8950.3 8630.1 8652.1 8728.6 8731.8 8770.9 6598.3 6814.8 6858.7 6890.6 6906.7 6224.3 6230.6 6234.2 6239.3 6257.6 7712.9 7756.7 7811.8 7821.0 7894.0 7889.0 8099.8 8104.8 8131.7 8219.8 6045.4 6151.3 6217.3 6243.3 6306.3 6273.3 6294.1 6309.7 6309.7 6310.4 6130.7 6191.5 6199.0 6218.2 6230.3 6173.6 6202.2 6203.3 6243.7 6291.5 6243.1 6260.4 6282.1 6283.6 6304.3 5871.4 5875.8 5892.1 5911.0 5931.0 5880.0 6068.5 6089.1 6103.1 6114.0 03:50:56 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | [#4] prototype.html Cycles:180 Average:4789.51 Median:5506.00 stddev:1415.95 (25.7%) stddev-sans-first:1379.38 03:50:56 INFO - PROCESS | 27353 | Values: 307.5 319.7 322.5 330.6 332.6 5439.1 5520.5 5552.9 5565.0 5707.5 5460.9 5485.8 5505.1 5506.9 5509.1 4132.9 4209.7 4215.8 4229.4 4242.2 4205.5 4207.7 4223.8 4234.5 4239.0 4153.0 4175.7 4181.0 4190.7 4194.8 4168.0 4179.9 4180.2 4188.0 4197.9 3635.3 3641.2 3650.5 3650.7 3651.1 5167.3 5277.9 5279.3 5290.2 5299.9 4830.2 4833.5 4842.1 4849.6 4849.8 5728.8 5729.5 5730.6 5745.1 5746.1 3973.9 3976.4 3979.0 3979.9 3981.7 5785.6 6016.5 6022.7 6031.2 6039.2 4115.6 4127.1 4134.1 4136.4 4154.2 4161.9 4187.6 4203.4 4203.7 4210.8 4825.5 4826.7 4828.7 4833.3 4847.7 5625.1 5714.0 5744.2 5750.3 5755.5 1460.2 1487.0 1490.5 1490.6 1496.6 981.6 985.0 990.2 996.2 1001.1 5029.3 5032.4 5033.3 5036.7 5045.0 5779.3 5841.7 5963.2 5970.4 6076.4 5060.5 5097.5 5097.7 5107.4 5107.7 3216.4 3229.2 3229.4 3248.1 3257.2 5485.0 5605.2 5646.8 5651.1 5660.4 6236.6 6238.6 6247.3 6248.5 6269.6 5681.9 5694.5 5698.0 5701.9 5702.3 6042.6 6061.2 6068.6 6072.9 6075.0 5766.9 5893.9 5914.8 5917.1 5921.3 5624.7 5661.2 5665.7 5677.1 5687.0 4117.1 4166.8 4167.0 4171.0 4176.7 5789.3 5994.2 6069.4 6072.6 6130.4 5802.7 5825.4 5830.8 5833.1 5854.2 5778.0 5805.7 5830.9 5847.8 5849.3 5604.5 5628.2 5675.7 5707.5 5718.6 5826.1 5836.2 5845.2 5854.9 5869.9 5581.5 5665.9 5682.6 5708.1 5722.6 03:50:56 INFO - PROCESS | 27353 | 03:50:56 INFO - PROCESS | 27353 | [#5] yui.html Cycles:180 Average:11722.50 Median:40752.30 stddev:12289.05 (30.2%) stddev-sans-first:12295.37 03:50:56 INFO - PROCESS | 27353 | Values: 645.5 717.5 734.0 737.6 742.4 10386.6 10616.3 11798.2 11969.8 11989.6 11733.2 12085.7 12103.6 12113.3 12124.7 771.2 781.4 783.1 789.7 790.0 762.6 767.1 768.4 773.1 776.4 810.7 813.1 813.4 819.4 819.8 808.3 812.0 812.5 812.6 814.7 597.6 602.9 603.2 603.5 604.5 11548.5 12059.8 12334.6 12365.8 12371.7 11639.8 11844.7 11939.0 11954.0 12369.3 9514.2 9648.8 9650.3 9659.9 9710.2 4068.7 4129.7 4140.9 4148.7 4285.6 40486.6 40594.0 40798.0 40916.0 41165.4 9485.0 9550.1 9565.1 9576.4 9926.0 16612.1 16717.5 16744.0 16749.7 16800.5 6712.8 6811.0 6836.4 6841.6 6964.3 3605.3 3634.0 3640.9 3703.3 3746.1 2547.4 2563.9 2564.9 2571.0 2574.0 472.9 479.8 484.8 486.1 491.3 463.1 464.9 477.6 519.1 579.3 8688.2 8730.4 8810.2 8815.5 8889.5 546.9 575.0 580.1 610.9 627.5 3626.8 3709.9 3761.5 4028.5 4040.2 39705.6 40127.6 40537.8 40589.8 40706.6 37665.8 37816.4 38266.2 40834.4 40992.8 36676.6 37014.3 37039.6 37218.8 37572.8 8267.1 8312.2 8394.7 8428.6 8582.3 28720.3 29131.4 29171.0 29390.3 29430.4 33842.3 35919.0 36056.0 36225.8 36600.5 10031.2 10109.2 10176.0 10234.9 10562.4 10659.1 11014.5 11095.2 11223.8 11273.3 10521.3 10631.8 10722.8 10932.7 11187.5 10551.5 10581.6 10759.8 10971.3 11256.3 10718.4 10783.5 10802.6 10809.6 10827.5 8871.6 8976.1 9152.5 9155.5 9221.3 9133.9 9158.4 9219.8 9322.6 9407.4 03:50:56 INFO - PROCESS | 27353 | -------- Summary: end -------- 03:50:56 INFO - PROCESS | 27353 | 03:50:57 INFO - TEST-INFO | 27353: exit 0 03:50:57 INFO - TEST-OK | dromaeo_css | took 1113277ms 03:50:57 INFO - TEST-START | kraken 03:50:57 INFO - operating with platform_type : linux_ 03:50:57 INFO - Initialising browser for kraken test... 03:50:57 INFO - TEST-INFO | started process 27591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Tqb4b/profile http://localhost:59456/getInfo.html) 03:51:01 INFO - PROCESS | 27591 | 03:51:01 INFO - PROCESS | 27591 | (process:27669): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:01 INFO - PROCESS | 27591 | __metrics Screen width/height:1600/1200 03:51:01 INFO - PROCESS | 27591 | colorDepth:24 03:51:01 INFO - PROCESS | 27591 | Browser inner width/height: 1024/697 03:51:01 INFO - PROCESS | 27591 | __metrics 03:51:02 INFO - PROCESS | 27591 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:51:03 INFO - TEST-INFO | 27591: exit 0 03:51:03 INFO - Browser initialized. 03:51:03 INFO - Running cycle 1/1 for kraken test... 03:51:03 INFO - TEST-INFO | started process 27718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Tqb4b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:04 INFO - PROCESS | 27718 | 03:51:04 INFO - PROCESS | 27718 | (process:27774): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:15 INFO - PROCESS | 27718 | RSS: Main: 149987328 03:51:15 INFO - PROCESS | 27718 | 03:51:17 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59456/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:18 INFO - PROCESS | 27718 | RSS: Main: 151384064 03:51:18 INFO - PROCESS | 27718 | 03:51:21 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59456/tests/kraken/driver.html?testName=audio-dft) 03:51:21 INFO - PROCESS | 27718 | RSS: Main: 153751552 03:51:21 INFO - PROCESS | 27718 | 03:51:24 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59456/tests/kraken/driver.html?testName=audio-fft) 03:51:25 INFO - PROCESS | 27718 | RSS: Main: 148135936 03:51:25 INFO - PROCESS | 27718 | 03:51:27 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59456/tests/kraken/driver.html?testName=audio-oscillator) 03:51:27 INFO - PROCESS | 27718 | RSS: Main: 147931136 03:51:27 INFO - PROCESS | 27718 | 03:51:30 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59456/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:30 INFO - PROCESS | 27718 | RSS: Main: 149078016 03:51:30 INFO - PROCESS | 27718 | 03:51:33 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59456/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:34 INFO - PROCESS | 27718 | RSS: Main: 148291584 03:51:34 INFO - PROCESS | 27718 | 03:51:37 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59456/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:38 INFO - PROCESS | 27718 | RSS: Main: 147853312 03:51:38 INFO - PROCESS | 27718 | 03:51:41 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59456/tests/kraken/driver.html?testName=json-parse-financial) 03:51:41 INFO - PROCESS | 27718 | RSS: Main: 148512768 03:51:41 INFO - PROCESS | 27718 | 03:51:43 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59456/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:44 INFO - PROCESS | 27718 | RSS: Main: 150040576 03:51:44 INFO - PROCESS | 27718 | 03:51:46 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59456/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:46 INFO - PROCESS | 27718 | RSS: Main: 149999616 03:51:46 INFO - PROCESS | 27718 | 03:51:48 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59456/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:49 INFO - PROCESS | 27718 | RSS: Main: 149712896 03:51:49 INFO - PROCESS | 27718 | 03:51:52 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:52 INFO - PROCESS | 27718 | RSS: Main: 149815296 03:51:52 INFO - PROCESS | 27718 | 03:51:55 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:55 INFO - PROCESS | 27718 | RSS: Main: 151093248 03:51:55 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:59456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59456/tests/kraken/driver.html?testName=ai-astar) 03:51:57 INFO - PROCESS | 27718 | RSS: Main: 150384640 03:51:57 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | __start_tp_report 03:51:57 INFO - PROCESS | 27718 | _x_x_mozilla_page_load 03:51:57 INFO - PROCESS | 27718 | _x_x_mozilla_page_load_details 03:51:57 INFO - PROCESS | 27718 | |i|pagename|runs| 03:51:57 INFO - PROCESS | 27718 | |0;ai-astar;113;108;113;112;112;123;113;113;112;114 03:51:57 INFO - PROCESS | 27718 | |1;audio-beat-detection;157;136;154;173;132;165;151;134;176;140 03:51:57 INFO - PROCESS | 27718 | |2;audio-dft;163;165;162;165;162;166;171;161;165;162 03:51:57 INFO - PROCESS | 27718 | |3;audio-fft;77;73;74;73;143;73;75;75;73;156 03:51:57 INFO - PROCESS | 27718 | |4;audio-oscillator;98;96;132;96;97;99;139;96;98;126 03:51:57 INFO - PROCESS | 27718 | |5;imaging-gaussian-blur;111;111;110;110;109;111;111;111;110;110 03:51:57 INFO - PROCESS | 27718 | |6;imaging-darkroom;148;150;147;147;149;148;148;146;148;149 03:51:57 INFO - PROCESS | 27718 | |7;imaging-desaturate;96;96;97;96;96;95;97;97;97;96 03:51:57 INFO - PROCESS | 27718 | |8;json-parse-financial;72;70;71;72;73;72;71;79;70;69 03:51:57 INFO - PROCESS | 27718 | |9;json-stringify-tinderbox;66;67;66;66;67;67;66;66;66;67 03:51:57 INFO - PROCESS | 27718 | |10;stanford-crypto-aes;83;85;91;93;90;91;86;93;85;85 03:51:57 INFO - PROCESS | 27718 | |11;stanford-crypto-ccm;127;127;122;132;119;133;129;124;122;122 03:51:57 INFO - PROCESS | 27718 | |12;stanford-crypto-pbkdf2;141;152;152;151;149;137;146;155;147;136 03:51:57 INFO - PROCESS | 27718 | |13;stanford-crypto-sha256-iterative;70;74;70;70;71;71;71;70;70;70 03:51:57 INFO - PROCESS | 27718 | __end_tp_report 03:51:57 INFO - PROCESS | 27718 | __start_cc_report 03:51:57 INFO - PROCESS | 27718 | _x_x_mozilla_cycle_collect,804 03:51:57 INFO - PROCESS | 27718 | __end_cc_report 03:51:57 INFO - PROCESS | 27718 | __startTimestamp1452858717987__endTimestamp 03:51:57 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | ------- Summary: start ------- 03:51:57 INFO - PROCESS | 27718 | Number of tests: 14 03:51:57 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:3.77 (3.3%) stddev-sans-first:4.00 03:51:57 INFO - PROCESS | 27718 | Values: 113.0 108.0 113.0 112.0 112.0 123.0 113.0 113.0 112.0 114.0 03:51:57 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:155.50 stddev:16.12 (10.4%) stddev-sans-first:16.99 03:51:57 INFO - PROCESS | 27718 | Values: 157.0 136.0 154.0 173.0 132.0 165.0 151.0 134.0 176.0 140.0 03:51:57 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:2.94 (1.8%) stddev-sans-first:3.08 03:51:57 INFO - PROCESS | 27718 | Values: 163.0 165.0 162.0 165.0 162.0 166.0 171.0 161.0 165.0 162.0 03:51:57 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | [#3] audio-fft Cycles:10 Average:89.20 Median:73.50 stddev:31.95 (43.5%) stddev-sans-first:33.59 03:51:57 INFO - PROCESS | 27718 | Values: 77.0 73.0 74.0 73.0 143.0 73.0 75.0 75.0 73.0 156.0 03:51:57 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:96.50 stddev:17.30 (17.9%) stddev-sans-first:17.99 03:51:57 INFO - PROCESS | 27718 | Values: 98.0 96.0 132.0 96.0 97.0 99.0 139.0 96.0 98.0 126.0 03:51:57 INFO - PROCESS | 27718 | 03:51:57 INFO - PROCESS | 27718 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:51:57 INFO - PROCESS | 27718 | Values: 111.0 111.0 110.0 110.0 109.0 111.0 111.0 111.0 110.0 110.0 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - PROCESS | 27718 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 03:51:58 INFO - PROCESS | 27718 | Values: 148.0 150.0 147.0 147.0 149.0 148.0 148.0 146.0 148.0 149.0 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - PROCESS | 27718 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:51:58 INFO - PROCESS | 27718 | Values: 96.0 96.0 97.0 96.0 96.0 95.0 97.0 97.0 97.0 96.0 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - PROCESS | 27718 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:72.00 stddev:2.77 (3.8%) stddev-sans-first:2.93 03:51:58 INFO - PROCESS | 27718 | Values: 72.0 70.0 71.0 72.0 73.0 72.0 71.0 79.0 70.0 69.0 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - PROCESS | 27718 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 03:51:58 INFO - PROCESS | 27718 | Values: 66.0 67.0 66.0 66.0 67.0 67.0 66.0 66.0 66.0 67.0 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - PROCESS | 27718 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:90.50 stddev:3.77 (4.2%) stddev-sans-first:3.49 03:51:58 INFO - PROCESS | 27718 | Values: 83.0 85.0 91.0 93.0 90.0 91.0 86.0 93.0 85.0 85.0 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - PROCESS | 27718 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:127.00 stddev:4.67 (3.7%) stddev-sans-first:4.93 03:51:58 INFO - PROCESS | 27718 | Values: 127.0 127.0 122.0 132.0 119.0 133.0 129.0 124.0 122.0 122.0 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - PROCESS | 27718 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:150.00 stddev:6.59 (4.4%) stddev-sans-first:6.67 03:51:58 INFO - PROCESS | 27718 | Values: 141.0 152.0 152.0 151.0 149.0 137.0 146.0 155.0 147.0 136.0 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - PROCESS | 27718 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:1.25 (1.8%) stddev-sans-first:1.30 03:51:58 INFO - PROCESS | 27718 | Values: 70.0 74.0 70.0 70.0 71.0 71.0 71.0 70.0 70.0 70.0 03:51:58 INFO - PROCESS | 27718 | -------- Summary: end -------- 03:51:58 INFO - PROCESS | 27718 | 03:51:58 INFO - TEST-INFO | 27718: exit 0 03:51:58 INFO - TEST-OK | kraken | took 61851ms 03:51:58 INFO - TEST-START | v8_7 03:51:58 INFO - operating with platform_type : linux_ 03:51:58 INFO - Initialising browser for v8_7 test... 03:51:59 INFO - TEST-INFO | started process 28003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXV92Ak/profile http://localhost:59456/getInfo.html) 03:52:02 INFO - PROCESS | 28003 | 03:52:02 INFO - PROCESS | 28003 | (process:28073): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:52:03 INFO - PROCESS | 28003 | __metrics Screen width/height:1600/1200 03:52:03 INFO - PROCESS | 28003 | colorDepth:24 03:52:03 INFO - PROCESS | 28003 | Browser inner width/height: 1024/697 03:52:03 INFO - PROCESS | 28003 | __metrics 03:52:03 INFO - PROCESS | 28003 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:52:04 INFO - TEST-INFO | 28003: exit 0 03:52:04 INFO - Browser initialized. 03:52:04 INFO - Running cycle 1/1 for v8_7 test... 03:52:04 INFO - TEST-INFO | started process 28122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXV92Ak/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:06 INFO - PROCESS | 28122 | 03:52:06 INFO - PROCESS | 28122 | (process:28180): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:52:16 INFO - PROCESS | 28122 | RSS: Main: 150745088 03:52:16 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | Cycle 1(1): loaded http://localhost:59456/tests/v8_7/run.html (next: http://localhost:59456/tests/v8_7/run.html) 03:52:39 INFO - PROCESS | 28122 | RSS: Main: 145883136 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | __start_tp_report 03:52:39 INFO - PROCESS | 28122 | _x_x_mozilla_page_load 03:52:39 INFO - PROCESS | 28122 | _x_x_mozilla_page_load_details 03:52:39 INFO - PROCESS | 28122 | |i|pagename|runs| 03:52:39 INFO - PROCESS | 28122 | |0;Richards;167.02856188408217 03:52:39 INFO - PROCESS | 28122 | |1;DeltaBlue;188.21757952192735 03:52:39 INFO - PROCESS | 28122 | |2;Encrypt;280.19052956010086 03:52:39 INFO - PROCESS | 28122 | |3;Decrypt;5202.072538860104 03:52:39 INFO - PROCESS | 28122 | |4;RayTrace;1061.5711252653928 03:52:39 INFO - PROCESS | 28122 | |5;Earley;706.7137809187279 03:52:39 INFO - PROCESS | 28122 | |6;Boyer;12345.67901234568 03:52:39 INFO - PROCESS | 28122 | |7;RegExp;43166.666666666664 03:52:39 INFO - PROCESS | 28122 | |8;Splay;598.5748218527316 03:52:39 INFO - PROCESS | 28122 | |9;NavierStokes;4835.748792270531 03:52:39 INFO - PROCESS | 28122 | __end_tp_report 03:52:39 INFO - PROCESS | 28122 | __startTimestamp1452858759470__endTimestamp 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | ------- Summary: start ------- 03:52:39 INFO - PROCESS | 28122 | Number of tests: 10 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#0] Richards Cycles:1 Average:167.03 Median:167.03 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 167.0 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#1] DeltaBlue Cycles:1 Average:188.22 Median:188.22 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 188.2 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 280.2 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 5202.1 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 1061.6 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#5] Earley Cycles:1 Average:706.71 Median:706.71 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 706.7 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 12345.7 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#7] RegExp Cycles:1 Average:43166.67 Median:43166.67 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 43166.7 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#8] Splay Cycles:1 Average:598.57 Median:598.57 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 598.6 03:52:39 INFO - PROCESS | 28122 | 03:52:39 INFO - PROCESS | 28122 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 03:52:39 INFO - PROCESS | 28122 | Values: 4835.7 03:52:39 INFO - PROCESS | 28122 | -------- Summary: end -------- 03:52:39 INFO - PROCESS | 28122 | 03:52:40 INFO - TEST-INFO | 28122: exit 0 03:52:40 INFO - TEST-OK | v8_7 | took 41449ms 03:52:40 INFO - SUITE-END | took 1216s 03:52:40 INFO - Completed test suite (00:20:16) 03:52:40 INFO - Working with test: dromaeo_css 03:52:40 INFO - Generating results file: dromaeo_css 03:52:40 INFO - Working with test: kraken 03:52:40 INFO - Generating results file: kraken 03:52:40 INFO - javascript benchmark 03:52:40 INFO - Working with test: v8_7 03:52:40 INFO - Generating results file: v8_7 03:52:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:52:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:52:40 INFO - process_Request line: dromaeo_css 6245.88 graph.html#tests=[[72,132,43]] 03:52:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:52:40 INFO - process_Request line: kraken 1550.40 graph.html#tests=[[232,132,43]] 03:52:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:52:40 INFO - process_Request line: v8_7 20311.20 graph.html#tests=[[230,132,43]] 03:52:40 INFO - RETURN: dromaeo_css: 6245.88 03:52:40 INFO - RETURN: kraken: 1550.40 03:52:40 INFO - RETURN: v8_7: 20311.20 03:52:40 INFO - javascript benchmark 03:52:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2616.123598594471, 2684.5302072137397, 2714.457108578285, 2718.7281271872816, 2731.1260396673065, 4455.821767129319, 4603.079384123176, 4620.330052142442, 4636.211843986522, 4641.5590518900735, 4503.0, 4512.887177820556, 4514.1423129605355, 4524.004718961832, 4576.5652263035045, 14.169744795898815, 4223.493180818306, 4229.794508565052, 4280.3151495760685, 4327.6754243431715, 4045.1505183911413, 4196.139791342767, 4247.87256382309, 4273.850415235467, 4284.078923031548, 4218.936715949248, 4247.575242475758, 4255.340422234559, 4285.292926667112, 4292.892677683051, 4210.536840947493, 4220.725652832556, 4229.111886503838, 4260.723053001576, 4262.978685106555, 4128.8348466061325, 4140.047789008515, 4206.26390381682, 4239.894002649928, 4255.744655320691, 4471.731696098212, 4473.82104715811, 4498.0, 4505.662075344362, 4526.094781043805, 4864.270359446076, 4871.14754917888, 4880.121578115938, 4892.0, 4936.728479933602, 4795.376601041842, 4907.288443175719, 4917.4344950330815, 4969.950300497021, 4990.201567749179, 4580.129775342708, 4597.057603191338, 4603.8158473661015, 4606.516315786861, 4626.8149274029, 4934.605231581465, 5035.0685123252315, 5041.2438134280155, 5057.190849464068, 5093.1087059764395, 4777.8327758528285, 4805.37530121082, 4810.975945120252, 4819.6867203631655, 4855.757212139379, 4933.925991110136, 4960.90078198434, 4966.329545511309, 4973.030259099513, 5014.89970200594, 4751.239801631791, 4849.248366503198, 4871.780769865364, 4896.853094407174, 4945.7774400152075, 4828.975855120702, 4851.223804191312, 4871.34236878017, 4887.486813884562, 4893.4617192108835, 4033.3143365627916, 4045.3931910213705, 4062.5531191568903, 4071.0, 4082.4692789937117, 3514.7715398499017, 3553.982230088833, 3575.1598374382, 3623.311570801592, 3630.0, 4236.216299984513, 4255.957440425618, 4266.338717498793, 4294.849680261176, 4307.0, 4873.658843880894, 4905.2151655734915, 4907.460179380265, 4909.140900342426, 4941.802327906844, 4212.431321771522, 4229.471316085489, 4259.574042595777, 4298.140371925628, 4317.266064768997, 4347.282698354799, 4355.891102722458, 4379.934300985487, 4380.934285985712, 4410.845620403271, 4623.815047398134, 4646.210144275481, 4662.883427914194, 4681.087187998308, 4715.764211789466, 4740.857774266778, 4777.4505931818285, 4810.4467986182035, 4837.709737415626, 4847.248676455155, 4605.861824145281, 4623.16782979067, 4633.096546173464, 4637.118947399983, 4638.489766125791, 4763.356946812136, 4823.2282834746275, 4835.371401717754, 4862.635302352409, 4878.9512104878495, 4843.6367272454, 4874.926876096791, 4911.8280860169725, 4912.189488734319, 4916.606671466203, 4774.4509381421585, 4818.68678535894, 4823.927641085316, 4826.541478559531, 4842.9757851211925, 4629.097326021528, 4736.928946065881, 4775.928361074517, 4789.0, 4833.73414462208, 4663.487016428258, 4686.437627484587, 4731.479537250969, 4731.787069581808, 4781.9043619128115, 4731.645126615449, 4754.144254034307, 4762.190427627243, 4782.928256076092, 4793.952060479351, 4588.334691469651, 4652.813887444464, 4668.533146685304, 4676.742779147179, 4687.953120468752], "unit": "score", "name": "dojo.html", "value": 4469.780709505908}, {"lowerIsBetter": false, "replicates": [505.2572718104387, 517.4489169034975, 522.1801771219185, 532.5393534592578, 559.8404454730403, 32677.50983735246, 33691.0, 33714.49428258572, 33736.15659608508, 33808.830955845246, 37039.4444083339, 37544.0, 37568.43647345292, 37586.43620345697, 37638.247235055285, 7630.4658673892845, 7814.76555703327, 7826.72606458774, 7840.490368126082, 7842.0, 7594.126675432341, 7669.194734552875, 7690.846183076335, 7694.846103077935, 7710.498817576868, 7837.451378403514, 7890.447668663196, 7895.092064412609, 7922.881156782624, 7935.603219839014, 7814.6092695365005, 7878.212178782133, 7902.841943161162, 7913.287804097658, 7931.722389716361, 7678.424118191158, 7737.264959828807, 7742.070951485802, 7796.337311328544, 7831.060272767304, 37004.44493332602, 37581.81209093937, 37668.0, 37677.43483847744, 37684.43473347902, 2464.778169964694, 2943.936429341529, 2982.925426864346, 3129.5775070365435, 3146.4179126861377, 23970.400739981465, 28032.0, 28956.42087158266, 29076.27309317263, 29257.853710731524, 3430.091025878144, 3440.569928758905, 3448.6551344865566, 3496.213351995806, 3513.350030244387, 180207.0, 181246.0, 181665.37509686826, 182247.0, 182287.99999999866, 46798.76600617043, 48091.519084809406, 50110.49889501131, 51750.74124629428, 52095.73952130215, 58977.0, 59358.703206484555, 60355.396446034974, 60509.69745151246, 60702.39297607056, 13711.314434278247, 13847.0, 13868.722625547432, 13922.234277114856, 13950.232737199349, 10954.123670106372, 10960.56157753681, 11015.173861960226, 11085.83371249432, 11127.833082503768, 18368.265269389343, 18977.24091036343, 19042.80957190438, 19046.714299285522, 19068.0, 7478.177400485943, 7727.1886451922865, 7727.624709614591, 7732.149463559004, 7839.764807055797, 883.1301168349171, 893.4103491695449, 945.3713280668278, 969.4619486185235, 997.81540415022, 27156.45687086287, 27313.044043458383, 27410.314742131606, 27436.45127097447, 27454.725452745617, 962.1436921140191, 986.7977064701719, 997.2271489595477, 1004.091297375876, 1065.3980501016902, 13684.589462316146, 13832.30838458073, 13843.377048032862, 14033.438662453591, 14309.499167529295, 290523.0, 299982.0, 300240.0, 301417.0, 301911.0, 47109.76445117752, 47857.521424786006, 48062.0, 48113.278300825514, 48119.75940120277, 1257.735875466144, 1291.0575280045432, 1297.9221246725226, 1303.7066660001424, 1305.1907817153426, 25673.614895776205, 26002.739972600033, 26111.0, 26181.214563563124, 26308.0, 39202.80398597989, 40045.59954400419, 40146.1970760589, 40233.39649905195, 40255.798721006206, 238093.0, 238586.0, 238718.0, 239036.0, 239790.0, 29515.40969180647, 32090.0, 32896.50655240125, 39419.2116157681, 41384.172316554104, 35066.0, 38300.0, 38864.80567597144, 38985.41521877231, 39264.05519585985, 32395.35209295848, 32398.35203295968, 32690.50964235586, 33465.83267083649, 34083.65916340805, 33291.334173316885, 34438.48342274918, 36544.26911461809, 39102.413463798635, 39783.80108099441, 33196.0, 33333.0, 33437.83281083579, 33452.0, 33461.16347091342, 25502.744972550037, 25667.0, 25726.485470290114, 26716.19851404461, 31758.364832702755, 18268.72596911074, 18334.0, 18374.35689750852, 18409.90795046016, 18419.53951151232], "unit": "score", "name": "ext.html", "value": 16720.096656338308}, {"lowerIsBetter": false, "replicates": [339.8674516938394, 342.66076584181656, 344.1636822521274, 346.8092549097996, 350.4515433346814, 14713.70572588549, 14786.18675972821, 15015.249237538133, 15634.84365156348, 16301.184940752973, 14691.191984440851, 14781.556553303391, 14937.775933361008, 15113.622159445991, 15117.622059448518, 4566.223741963874, 4937.0, 5143.897122057557, 5145.691258524482, 5145.691258524501, 5051.9494805051845, 5070.569001634847, 5077.162268225738, 5096.796128154888, 5444.183372494138, 4990.925136122961, 5218.1650935850275, 5223.085959956992, 5749.166370876242, 5771.653700777946, 5108.182690769459, 5136.383633963929, 5154.329937108152, 5165.35433070868, 5185.066687996159, 5971.28344598651, 6241.407066328691, 6255.186825712628, 6269.090981807658, 6287.088372186053, 17930.462086137435, 18584.256629734795, 19180.71228931567, 19280.4215873524, 20838.5832283355, 1963.2539634938776, 1972.8323092537153, 1975.6345076160812, 2038.175832629803, 2121.893905304744, 13225.470981160743, 13278.07053506255, 13358.732825343439, 13493.392797324144, 13823.79264311036, 1796.1378538301688, 1799.640071985608, 1871.4759867237196, 1887.5658598522416, 1936.2738972885168, 54377.0, 55658.44341556573, 56754.0, 57940.42059579435, 58463.415365846224, 14661.413543458142, 14668.311910197603, 14683.55949321522, 14746.336414861142, 15191.468298609496, 21868.78131218699, 21874.453138671342, 21881.452963676034, 21960.780392195873, 21988.450288742908, 8400.579971001425, 8436.873446898302, 8441.451305665112, 8468.830623387497, 8501.06488286288, 7101.076860008269, 7120.608366539786, 7157.1769246537315, 7159.821004474826, 7204.711811527585, 7217.278272172845, 7275.490715649854, 7333.339999400079, 7371.373433258126, 7387.187409384964, 2842.8862845486365, 2944.9263768405963, 2954.1580649514785, 2974.925626859346, 3056.205386599456, 397.2928187825675, 402.1895879802201, 417.4677286459788, 418.4016855896037, 432.112009819817, 14293.213873237071, 15511.922440387725, 15557.29992150356, 15840.0, 16155.919220403823, 862.6808081010066, 883.9204471597587, 901.7384958362132, 924.2513564013171, 927.5408672707053, 8871.423357481743, 8936.910630893608, 8938.24024957886, 9008.009118996904, 9107.908920910839, 416729.0, 426973.0, 429343.0, 431772.0, 432543.0, 38963.662180269275, 40483.0, 55636.443635563126, 61906.69046654828, 64684.0, 1106.8450416941473, 1111.8221084626582, 1122.7754449110212, 1129.9039581635652, 1132.116948779953, 12672.746545068863, 13190.406431710788, 13711.657208569866, 13815.240161791198, 14052.718945621235, 26891.865540672956, 27369.17892463229, 27952.58071128894, 28359.716402836533, 28522.144335669964, 32056.83971580127, 32670.673293266762, 32812.343753124325, 32967.83516082404, 32971.340573188885, 6642.701078451578, 6681.599104053578, 6720.025596288413, 6782.118324617768, 6823.4882383822405, 9009.324300677607, 9946.254030947852, 10061.245406594388, 10226.437545935045, 10385.792284154426, 8446.450980686235, 8647.01421044239, 8825.646974120964, 8949.239314658067, 9016.549172541478, 6696.665166741741, 8869.201771840566, 9094.363394562582, 9173.35786494939, 9539.284553658365, 2824.844633545175, 2842.3178437175343, 9360.95319523398, 9439.820022497188, 9503.097205765442, 6515.543911926309, 6581.934180658323, 6623.569467984566, 6658.0, 6776.28848970851, 8942.50816205115, 9098.0, 9437.245020398213, 9509.572069256761, 9553.904460955302], "unit": "score", "name": "jquery.html", "value": 7962.911899845462}, {"lowerIsBetter": false, "replicates": [1374.168627980072, 1389.8332200135983, 1503.54141986694, 1699.5581148901283, 1714.8799584029107, 6122.785702500413, 6206.596571222867, 6946.756863509778, 7212.278772122791, 7212.56724596524, 6735.124433823608, 6850.417714494261, 6929.584224946494, 6946.861062778741, 6959.5476294040855, 2106.7682554918983, 2134.551744133734, 2134.8505604607685, 2136.3484137338182, 2137.7862213778576, 2157.622416077188, 2179.7602263750973, 2182.3452964110784, 2182.3998400439846, 2182.9454263643456, 2149.570085982802, 2164.047818959653, 2168.7072245246845, 2179.4333473296897, 2192.5176461178594, 2173.4240426287124, 2176.09691977829, 2181.879996600186, 2182.23621732394, 2184.2682701295084, 2100.653392190287, 2136.316378758798, 2138.1661152150673, 2139.775323591032, 2139.9465013374634, 7264.0, 7312.195658477616, 7315.0, 7317.0487836580905, 7332.8900066499045, 4256.106217694288, 4325.221460137174, 4347.0, 4390.297552391634, 4392.604665580113, 2748.051922086877, 2789.916302510928, 2820.0411859967503, 2824.61867647867, 2826.434713057397, 863.1282404771226, 897.4301318662631, 898.8606765951288, 899.5277479323343, 922.1654402765508, 9853.556589953469, 9869.703908882744, 9872.407655540619, 9877.654282100091, 9916.157126644172, 4049.8582549610624, 4096.877093687194, 4108.958910410917, 4172.08214192877, 4194.748315101104, 8353.0, 8362.289205417486, 8365.330773538102, 8438.789030274293, 8454.196851299117, 4386.254336762758, 4405.207062728739, 4413.668974826901, 4419.64642828573, 4461.174682683714, 3417.8974630761118, 3480.89557313281, 3848.461215429842, 4018.136100738297, 4037.9394309085387, 3508.614052454228, 3519.1202199450136, 3547.201879577126, 3564.697000754913, 3604.116991337139, 1083.101026148295, 1094.885037071112, 1124.173732306754, 1125.662301309604, 1130.7229728716518, 1106.983395249072, 1115.1859142825783, 1134.5972179876026, 1137.766757814646, 1145.7135716070982, 6399.9040014399825, 6437.452816510649, 6454.806355809334, 6459.61242325462, 6474.1907261592305, 411.04842290098924, 411.05047340642614, 413.19427117121734, 414.44878311845173, 414.72420840140967, 4947.82682606107, 4949.678270912451, 4989.3264409305, 5004.524570165829, 5030.547250747451, 8546.871796923051, 8848.247898928663, 8854.557272136497, 8863.867041994376, 8950.328725345626, 8630.136986301319, 8652.134786521423, 8728.607212675444, 8731.825363492695, 8770.868436973451, 6598.307177746364, 6814.795556133324, 6858.725650974005, 6890.621015844176, 6906.723731050803, 6224.2842073160355, 6230.563860529719, 6234.220722409699, 6239.251289845248, 6257.624542527463, 7712.884306735291, 7756.650950707119, 7811.804704882424, 7821.0, 7893.960530197312, 7888.960555197187, 8099.797505062421, 8104.837903241784, 8131.715389961323, 8219.83560328802, 6045.425684559959, 6151.32335443092, 6217.253929528486, 6243.282022567463, 6306.306306306211, 6273.309935906956, 6294.0558916162945, 6309.652969086745, 6309.684515774285, 6310.368963103837, 6130.662813545119, 6191.504679625709, 6199.0, 6218.19163508741, 6230.252369715663, 6173.629582224901, 6202.162708034358, 6203.348648392034, 6243.656598887105, 6291.465225455888, 6243.094751260951, 6260.373962603703, 6282.120503129657, 6283.5601507895835, 6304.338044505261, 5871.383504731942, 5875.794347197828, 5892.057270836645, 5911.0, 5931.021381472009, 5879.970600147143, 6068.514518838394, 6089.086637004308, 6103.11504831788, 6114.0], "unit": "score", "name": "mootools.html", "value": 4030.1852573537203}, {"lowerIsBetter": false, "replicates": [307.53869196205693, 319.6739325887594, 322.46470858375085, 330.5702586637371, 332.5776264144535, 5439.102548079567, 5520.5307548858345, 5552.86117847053, 5564.9999999999945, 5707.5148612368, 5460.890782184354, 5485.807996720116, 5505.146702261146, 5506.862328441791, 5509.090999985007, 4132.917341653165, 4209.705320627558, 4215.810288537008, 4229.36559516072, 4242.172776308621, 4205.453291072172, 4207.705460617758, 4223.838444427792, 4234.513031001428, 4239.0, 4152.97923510382, 4175.749455032693, 4180.975660963069, 4190.727602705814, 4194.769287689176, 4168.0, 4179.853705120321, 4180.205760905449, 4187.958120418787, 4197.9370309445385, 3635.3456377851976, 3641.198936234024, 3650.5254316938895, 3650.7261955353188, 3651.087228192952, 5167.3282473278605, 5277.894442111136, 5279.260903473517, 5290.153575427951, 5299.947000530023, 4830.178869592178, 4833.540813622701, 4842.055799119174, 4849.563539281482, 4849.830255941025, 5728.828135155952, 5729.541636669056, 5730.570207234474, 5745.109508026221, 5746.080627099685, 3973.860914867995, 3976.363781794899, 3979.0251388410024, 3979.900502487432, 3981.661558767479, 5785.62393444429, 6016.548758843061, 6022.728977196037, 6031.2159419276095, 6039.245094363205, 4115.58844115592, 4127.071408933026, 4134.111166099243, 4136.358864375967, 4154.231467178522, 4161.9375709364385, 4187.560306167808, 4203.4115223868685, 4203.684723645739, 4210.7684077375425, 4825.541573550507, 4826.710397376169, 4828.686135401188, 4833.275008748716, 4847.660663753503, 5625.128105143709, 5713.971430142906, 5744.167095771089, 5750.25246717924, 5755.453231942959, 1460.167704408477, 1487.0408586461888, 1490.5453836579948, 1490.5528341497507, 1496.5585152380074, 981.6367943860674, 984.9953047891111, 990.2276224544867, 996.2378780233128, 1001.1240164855751, 5029.346184995927, 5032.446430892599, 5033.320501732219, 5036.697798132123, 5045.041442125985, 5779.335376431764, 5841.7371218295275, 5963.224780778558, 5970.402959703995, 6076.392360763888, 5060.51925067118, 5097.515736005073, 5097.719625420637, 5107.438181799999, 5107.7446127693465, 3216.437123503424, 3229.2088438332758, 3229.434848901433, 3248.0742988248235, 3257.2019855135645, 5484.972575137099, 5605.159226116115, 5646.830595082154, 5651.0675738503505, 5660.377358490563, 6236.6258024518675, 6238.563300568917, 6247.250329960434, 6248.4688801452385, 6269.592476489013, 5681.857953551194, 5694.487496125285, 5698.031334673115, 5701.914471282934, 5702.315722113373, 6042.637441753509, 6061.1514387984835, 6068.605540639845, 6072.939270607238, 6074.969625151846, 5766.855828604318, 5893.939090963668, 5914.792982245601, 5917.053271476543, 5921.3190483094995, 5624.7187640616985, 5661.179129026351, 5665.716714164358, 5677.148427735708, 5687.0, 4117.114820313647, 4166.7708276045105, 4167.041580436456, 4171.0, 4176.686748493815, 5789.305283366023, 5994.160817485468, 6069.423404776539, 6072.635641861326, 6130.41761032719, 5802.6808525531505, 5825.3883342248455, 5830.7959221427045, 5833.095870140135, 5854.180414742024, 5778.0, 5805.680687562224, 5830.941690583039, 5847.766089356378, 5849.327327357409, 5604.510752956505, 5628.212050313042, 5675.716214189357, 5707.4577915098, 5718.571107166896, 5826.067829147316, 5836.212111365081, 5845.152452894392, 5854.912176317273, 5869.94130058711, 5581.469760372758, 5665.886682266249, 5682.602217844711, 5708.115242137475, 5722.570807189561], "unit": "score", "name": "prototype.html", "value": 4336.699920090715}, {"lowerIsBetter": false, "replicates": [645.4932877691012, 717.4521988765556, 734.0274136768776, 737.6016950846544, 742.3986570877589, 10386.584536618526, 10616.309939853903, 11798.174127811057, 11969.76060478791, 11989.580364687237, 11733.178677492579, 12085.697857553565, 12103.636890893287, 12113.273203607767, 12124.69688257794, 771.1748429180778, 781.3944193250248, 783.1307248953657, 789.6841263494591, 790.0124843945068, 762.6225018615793, 767.0986590755867, 768.4313607930147, 773.0645918438668, 776.3633820267383, 810.6919370639179, 813.0649752784286, 813.3899575318511, 819.4304958054155, 819.7950512371907, 808.2564041082219, 811.975640730779, 812.4556547113418, 812.5652775764937, 814.6578437056451, 597.6354423801478, 602.9035354343328, 603.2429301226932, 603.4629180029777, 604.5103466192398, 11548.53805847765, 12059.819102713467, 12334.568290109803, 12365.752684946341, 12371.690707732289, 11639.76720465586, 11844.703882402922, 11939.0, 11954.0, 12369.319687417188, 9514.238860891111, 9648.75878103046, 9650.324477286593, 9659.90340096597, 9710.223182145412, 4068.65416439603, 4129.731567448106, 4140.896477588084, 4148.688848336386, 4285.592868677501, 40486.59513404858, 40594.0, 40798.0, 40916.0, 41165.38251926223, 9484.95257523708, 9550.092741189575, 9565.091316324939, 9576.425414475154, 9925.950370248103, 16612.08633525168, 16717.49847504577, 16744.0, 16749.665006699797, 16800.495985120466, 6712.765053223211, 6810.965945170342, 6836.384725374641, 6841.589504629738, 6964.338387853146, 3605.3149901518627, 3634.0, 3640.927181456409, 3703.2778608171147, 3746.063484128968, 2547.3886267295716, 2563.910263140781, 2564.8974041038523, 2570.974290257111, 2574.034736973635, 472.8983268597268, 479.7673128532659, 484.7745798203852, 486.1007136796968, 491.31461611053095, 463.07154155917846, 464.86518909516536, 477.59404506169477, 519.0708631549484, 579.2990481517327, 8688.174623410765, 8730.38887277897, 8810.207081362709, 8815.471071735716, 8889.511076890703, 546.9042917489423, 574.9597528172987, 580.077676494376, 610.88087822875, 627.5011365964069, 3626.801887680059, 3709.870154544578, 3761.5298087739034, 4028.4964379452567, 4040.1919616076902, 39705.60294397019, 40127.59872401297, 40537.79731101326, 40589.79705101515, 40706.592934070875, 37665.81167094202, 37816.43275350872, 38266.23467530634, 40834.38748418776, 40992.79503602463, 36676.63323366785, 37014.25971480555, 37039.629603704154, 37218.81390593084, 37572.81213593969, 8267.131951145044, 8312.21034001769, 8394.748157555283, 8428.620712068094, 8582.270507006975, 28720.281992950342, 29131.41737165287, 29171.0, 29390.265243369086, 29430.411391771617, 33842.32315353728, 35919.0, 36056.0, 36225.818870905474, 36600.45099323459, 10031.247656425652, 10109.19126469866, 10176.0, 10234.948825255826, 10562.419066951392, 10659.09397701204, 11014.504347304552, 11095.223334366518, 11223.775524489627, 11273.323600583992, 10521.263511554118, 10631.787364252827, 10722.839157412802, 10932.726681833017, 11187.496562654538, 10551.472426378497, 10581.62438882971, 10759.838602420814, 10971.286866353661, 11256.268342557707, 10718.410487423267, 10783.514741836792, 10802.567897284021, 10809.56761729522, 10827.458627068458, 8871.64513419456, 8976.102389760972, 9152.542372881197, 9155.450672959643, 9221.262299016196, 9133.908660913572, 9158.40470369424, 9219.76950576241, 9322.627094916399, 9407.388519746195], "unit": "score", "name": "yui.html", "value": 5707.362730193016}], "name": "dromaeo_css", "value": 6245.878599416863}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 113.0, 112.0, 112.0, 123.0, 113.0, 113.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [157.0, 136.0, 154.0, 173.0, 132.0, 165.0, 151.0, 134.0, 176.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 151.8}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 162.0, 165.0, 162.0, 166.0, 171.0, 161.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 74.0, 73.0, 143.0, 73.0, 75.0, 75.0, 73.0, 156.0], "unit": "score", "name": "audio-fft", "value": 89.2}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 132.0, 96.0, 97.0, 99.0, 139.0, 96.0, 98.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 109.0, 111.0, 111.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 147.0, 147.0, 149.0, 148.0, 148.0, 146.0, 148.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 71.0, 72.0, 73.0, 72.0, 71.0, 79.0, 70.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 91.0, 93.0, 90.0, 91.0, 86.0, 93.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [127.0, 127.0, 122.0, 132.0, 119.0, 133.0, 129.0, 124.0, 122.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 152.0, 151.0, 149.0, 137.0, 146.0, 155.0, 147.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 70.0, 70.0, 71.0, 71.0, 71.0, 70.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1550.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.02856188408217], "unit": "score", "name": "Richards", "value": 211.35307400000002}, {"lowerIsBetter": false, "replicates": [188.21757952192735], "unit": "score", "name": "DeltaBlue", "value": 351.2849339999999}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [706.7137809187279], "unit": "score", "name": "Earley", "value": 943.0451449999999}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [43166.666666666664], "unit": "score", "name": "RegExp", "value": 21.103899613899614}, {"lowerIsBetter": false, "replicates": [598.5748218527316], "unit": "score", "name": "Splay", "value": 136.14171031746028}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20311.197830882564}]} 03:52:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20311.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1550.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6245.88"}}} 03:52:40 INFO - Return code: 0 03:52:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:52:40 INFO - # TBPL SUCCESS # 03:52:40 INFO - Running post-action listener: _resource_record_post_action 03:52:40 INFO - Running post-run listener: _resource_record_post_run 03:52:41 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545759232; Read time: 52; Write time: 455192 03:52:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236924928; Read time: 0; Write time: 280336 03:52:41 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308834304; Read time: 52; Write time: 174856 03:52:41 INFO - Running post-run listener: _upload_blobber_files 03:52:41 INFO - Blob upload gear active. 03:52:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:41 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 03:52:41 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'] 03:52:41 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 03:52:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:43 INFO - (blobuploader) - INFO - Done attempting. 03:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:44 INFO - (blobuploader) - INFO - Done attempting. 03:52:44 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:44 INFO - Return code: 0 03:52:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74360afa8d276f1e75ca707b12d2b961be010f6408c2b0aa95223d8e27d175d79282a21ac344244c2a56e21e0cebc97f0bbdc25e73b677f36f9f07f40ac4cd69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f41b88e530e35ba7f01a9fd7d04ccd67082b411b729ee932014d4ba1164b2621b65fd3e5207afb8cb0bfbb2b49a343debf38deccf33ddc4df6694bc97167f5b2"} 03:52:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:44 INFO - Contents: 03:52:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74360afa8d276f1e75ca707b12d2b961be010f6408c2b0aa95223d8e27d175d79282a21ac344244c2a56e21e0cebc97f0bbdc25e73b677f36f9f07f40ac4cd69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f41b88e530e35ba7f01a9fd7d04ccd67082b411b729ee932014d4ba1164b2621b65fd3e5207afb8cb0bfbb2b49a343debf38deccf33ddc4df6694bc97167f5b2"} 03:52:44 INFO - Copying logs to upload dir... 03:52:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.160664 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-15 03:52:44.186358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 03:52:44.189960) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74360afa8d276f1e75ca707b12d2b961be010f6408c2b0aa95223d8e27d175d79282a21ac344244c2a56e21e0cebc97f0bbdc25e73b677f36f9f07f40ac4cd69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f41b88e530e35ba7f01a9fd7d04ccd67082b411b729ee932014d4ba1164b2621b65fd3e5207afb8cb0bfbb2b49a343debf38deccf33ddc4df6694bc97167f5b2"} build_url:https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/Z-nmEOXZQPGUUjJZfddl4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74360afa8d276f1e75ca707b12d2b961be010f6408c2b0aa95223d8e27d175d79282a21ac344244c2a56e21e0cebc97f0bbdc25e73b677f36f9f07f40ac4cd69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f41b88e530e35ba7f01a9fd7d04ccd67082b411b729ee932014d4ba1164b2621b65fd3e5207afb8cb0bfbb2b49a343debf38deccf33ddc4df6694bc97167f5b2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 03:52:44.214155) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:52:44.214450) ========= 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=652eb03db935cfc1c15ebda0000001ad-1452857279.506247-1083740030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 03:52:44.296942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 03:52:44.297213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 03:52:44.297489) ========= ========= Total master_lag: 0.24 =========