builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1451969246.67 results: success (0) buildid: 20160104202241 builduid: 34a4e80f76d843c09cf69857b4a5f497 revision: 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.666933) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.667597) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.668000) ========= 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=232498196343f89f466a4a9a000001c8-1451969246.958566-865673897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004368 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.687371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.687883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.702601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.703515) ========= 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=232498196343f89f466a4a9a000001c8-1451969246.958566-865673897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.754340) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.754719) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.755172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.755515) ========= 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=232498196343f89f466a4a9a000001c8-1451969246.958566-865673897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 20:47:27-- 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% 224M=0s 2016-01-04 20:47:27 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.862631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.863025) ========= 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=232498196343f89f466a4a9a000001c8-1451969246.958566-865673897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.914588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:26.915093) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb --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=232498196343f89f466a4a9a000001c8-1451969246.958566-865673897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 20:47:28,031 truncating revision to first 12 chars 2016-01-04 20:47:28,031 Setting DEBUG logging. 2016-01-04 20:47:28,031 attempt 1/10 2016-01-04 20:47:28,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/740ebb163d6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 20:47:28,290 unpacking tar archive at: b2g-inbound-740ebb163d6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565604 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:27.497859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:27.498640) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:27.509638) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:27.510078) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 20:47:27.510842) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-04 20:47:27.511403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=232498196343f89f466a4a9a000001c8-1451969246.958566-865673897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:47:28 INFO - MultiFileLogger online at 20160104 20:47:28 in /builds/slave/test 20:47:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 20:47:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:47:28 INFO - {'append_to_log': False, 20:47:28 INFO - 'base_work_dir': '/builds/slave/test', 20:47:28 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 20:47:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:47:28 INFO - 'branch': 'B2G-Inbound-Non-PGO', 20:47:28 INFO - 'buildbot_json_path': 'buildprops.json', 20:47:28 INFO - 'config_files': ('talos/linux_config.py',), 20:47:28 INFO - 'default_actions': ('clobber', 20:47:28 INFO - 'read-buildbot-config', 20:47:28 INFO - 'download-and-extract', 20:47:28 INFO - 'populate-webroot', 20:47:28 INFO - 'create-virtualenv', 20:47:28 INFO - 'install', 20:47:28 INFO - 'run-tests'), 20:47:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:47:28 INFO - 'download_minidump_stackwalk': True, 20:47:28 INFO - 'download_symbols': 'ondemand', 20:47:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:47:28 INFO - 'tooltool.py': '/tools/tooltool.py', 20:47:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:47:28 INFO - '/tools/misc-python/virtualenv.py')}, 20:47:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:47:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:47:28 INFO - 'installer_path': 'installer.exe', 20:47:28 INFO - 'log_level': 'info', 20:47:28 INFO - 'log_name': 'talos', 20:47:28 INFO - 'log_to_console': True, 20:47:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:47:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:47:28 INFO - 'opt_config_files': (), 20:47:28 INFO - 'pip_index': False, 20:47:28 INFO - 'sps_profile': False, 20:47:28 INFO - 'sps_profile_interval': 0, 20:47:28 INFO - 'suite': 'dromaeojs', 20:47:28 INFO - 'system_bits': '32', 20:47:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:47:28 INFO - 'title': 'talos-linux64-ix-025', 20:47:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:47:28 INFO - 'use_talos_json': True, 20:47:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:47:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:47:28 INFO - 'work_dir': 'build'} 20:47:28 INFO - ##### 20:47:28 INFO - ##### Running clobber step. 20:47:28 INFO - ##### 20:47:28 INFO - Running pre-action listener: _resource_record_pre_action 20:47:28 INFO - Running main action method: clobber 20:47:28 INFO - rmtree: /builds/slave/test/build 20:47:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:47:29 INFO - Running post-action listener: _resource_record_post_action 20:47:29 INFO - ##### 20:47:29 INFO - ##### Running read-buildbot-config step. 20:47:29 INFO - ##### 20:47:29 INFO - Running pre-action listener: _resource_record_pre_action 20:47:29 INFO - Running main action method: read_buildbot_config 20:47:29 INFO - Using buildbot properties: 20:47:29 INFO - { 20:47:29 INFO - "project": "", 20:47:29 INFO - "product": "firefox", 20:47:29 INFO - "script_repo_revision": "production", 20:47:29 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 20:47:29 INFO - "repository": "", 20:47:29 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 20:47:29 INFO - "buildid": "20160104202241", 20:47:29 INFO - "pgo_build": "False", 20:47:29 INFO - "basedir": "/builds/slave/test", 20:47:29 INFO - "buildnumber": 813, 20:47:29 INFO - "slavename": "talos-linux64-ix-025", 20:47:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:47:29 INFO - "platform": "ubuntu64_hw", 20:47:29 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 20:47:29 INFO - "branch": "b2g-inbound", 20:47:29 INFO - "repo_path": "integration/b2g-inbound", 20:47:29 INFO - "revision": "740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb", 20:47:29 INFO - "stage_platform": "linux64", 20:47:29 INFO - "builduid": "34a4e80f76d843c09cf69857b4a5f497", 20:47:29 INFO - "slavebuilddir": "test" 20:47:29 INFO - } 20:47:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:47:29 INFO - Running post-action listener: _resource_record_post_action 20:47:29 INFO - ##### 20:47:29 INFO - ##### Running download-and-extract step. 20:47:29 INFO - ##### 20:47:29 INFO - Running pre-action listener: _resource_record_pre_action 20:47:29 INFO - Running main action method: download_and_extract 20:47:29 INFO - mkdir: /builds/slave/test/build/tests 20:47:29 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')]} 20:47:29 INFO - https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:47:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/test_packages.json 20:47:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/test_packages.json 20:47:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:47:30 INFO - Downloaded 1302 bytes. 20:47:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:47:30 INFO - Using the following test package requirements: 20:47:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:47:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:47:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:47:30 INFO - u'jsshell-linux-x86_64.zip'], 20:47:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:47:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:47:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:47:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:47:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:47:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:47:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:47:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:47: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')]} 20:47:30 INFO - https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/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 20:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/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 20:47:31 INFO - Downloaded 21949420 bytes. 20:47:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:47:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:47:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:47:32 INFO - Return code: 0 20:47:32 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 20:47:32 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')]} 20:47:32 INFO - https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/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 20:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/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 20:47:33 INFO - Downloaded 21949420 bytes. 20:47:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:47:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:47:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:47:34 INFO - Return code: 0 20:47: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')]} 20:47:34 INFO - https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/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 20:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/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 20:47:35 INFO - Downloaded 11132285 bytes. 20:47:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 20:47:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:47:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:47:36 INFO - Return code: 0 20:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:36 INFO - https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/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 20:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2WefWCUQriN_WmXYcVBlA/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 20:47:37 INFO - Downloaded 53377806 bytes. 20:47:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:47:37 INFO - mkdir: /builds/slave/test/properties 20:47:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:47:37 INFO - Writing to file /builds/slave/test/properties/build_url 20:47:37 INFO - Contents: 20:47:37 INFO - build_url:https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:47:37 INFO - Running post-action listener: _resource_record_post_action 20:47:37 INFO - Running post-action listener: set_extra_try_arguments 20:47:37 INFO - ##### 20:47:37 INFO - ##### Running populate-webroot step. 20:47:37 INFO - ##### 20:47:37 INFO - Running pre-action listener: _resource_record_pre_action 20:47:37 INFO - Running main action method: populate_webroot 20:47:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:47:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:47:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:47:37 INFO - '--tppagecycles', 20:47:37 INFO - '7'], 20:47:37 INFO - 'tests': ['tsvgm']}}, 20:47:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:47:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:47:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:47:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:47:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:47:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:37 INFO - 'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:47:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:37 INFO - 'tests': ['damp', 'tps']}, 20:47:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:37 INFO - 'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['damp', 'tps']}, 20:47:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:47:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:47:37 INFO - 'other': {'tests': ['a11yr', 20:47:37 INFO - 'ts_paint', 20:47:37 INFO - 'tpaint', 20:47:37 INFO - 'sessionrestore', 20:47:37 INFO - 'sessionrestore_no_auto_restore']}, 20:47:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['a11yr', 20:47:37 INFO - 'ts_paint', 20:47:37 INFO - 'tpaint', 20:47:37 INFO - 'sessionrestore', 20:47:37 INFO - 'sessionrestore_no_auto_restore']}, 20:47:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['a11yr', 20:47:37 INFO - 'ts_paint', 20:47:37 INFO - 'tpaint', 20:47:37 INFO - 'sessionrestore', 20:47:37 INFO - 'sessionrestore_no_auto_restore']}, 20:47:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['a11yr', 20:47:37 INFO - 'ts_paint', 20:47:37 INFO - 'tpaint', 20:47:37 INFO - 'sessionrestore', 20:47:37 INFO - 'sessionrestore_no_auto_restore']}, 20:47:37 INFO - 'other_l64': {'tests': ['a11yr', 20:47:37 INFO - 'ts_paint', 20:47:37 INFO - 'tpaint', 20:47:37 INFO - 'sessionrestore', 20:47:37 INFO - 'sessionrestore_no_auto_restore']}, 20:47:37 INFO - 'other_nol64': {'tests': ['a11yr', 20:47:37 INFO - 'ts_paint', 20:47:37 INFO - 'tpaint', 20:47:37 INFO - 'sessionrestore', 20:47:37 INFO - 'sessionrestore_no_auto_restore']}, 20:47:37 INFO - 'svgr': {'tests': ['tsvgx', 20:47:37 INFO - 'tsvgr_opacity', 20:47:37 INFO - 'tart', 20:47:37 INFO - 'tscrollx', 20:47:37 INFO - 'cart']}, 20:47:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['tsvgx', 20:47:37 INFO - 'tsvgr_opacity', 20:47:37 INFO - 'tart', 20:47:37 INFO - 'tscrollx', 20:47:37 INFO - 'cart']}, 20:47:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:37 INFO - 'tests': ['tp5o']}, 20:47:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:37 INFO - 'talos_options': ['--e10s'], 20:47:37 INFO - 'tests': ['tp5o']}, 20:47:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:37 INFO - 'talos_options': ['--xperf_path', 20:47:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:47:37 INFO - 'tests': ['tp5n']}, 20:47:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:37 INFO - 'talos_options': ['--e10s', 20:47:37 INFO - '--xperf_path', 20:47:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:47:37 INFO - 'tests': ['tp5n']}}, 20:47:37 INFO - 'talos.zip': {'path': '', 20:47:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:47:37 INFO - Running post-action listener: _resource_record_post_action 20:47:37 INFO - ##### 20:47:37 INFO - ##### Running create-virtualenv step. 20:47:37 INFO - ##### 20:47:37 INFO - Running pre-action listener: _resource_record_pre_action 20:47:37 INFO - Running main action method: create_virtualenv 20:47:37 INFO - Creating virtualenv /builds/slave/test/build/venv 20:47:37 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 20:47:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:47:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:47:38 INFO - Using real prefix '/usr' 20:47:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:47:38 INFO - Installing distribute.............................................................................................................................................................................................done. 20:47:40 INFO - Installing pip.................done. 20:47:40 INFO - Return code: 0 20:47:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:47: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')]} 20:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47: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')]} 20:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:40 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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:40 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 20:47:40 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 20:47:40 INFO - Using env: {'DISPLAY': ':0', 20:47:40 INFO - 'HOME': '/home/cltbld', 20:47:40 INFO - 'LANG': 'en_US.UTF-8', 20:47:40 INFO - 'LANGUAGE': 'en_US:en', 20:47:40 INFO - 'LOGNAME': 'cltbld', 20:47:40 INFO - 'MAIL': '/var/mail/cltbld', 20:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:40 INFO - 'MOZ_NO_REMOTE': '1', 20:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:40 INFO - 'NO_EM_RESTART': '1', 20:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:40 INFO - 'PWD': '/builds/slave/test', 20:47:40 INFO - 'SHELL': '/bin/bash', 20:47:40 INFO - 'SHLVL': '1', 20:47:40 INFO - 'TERM': 'linux', 20:47:40 INFO - 'TMOUT': '86400', 20:47:40 INFO - 'USER': 'cltbld', 20:47:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:40 INFO - '_': '/tools/buildbot/bin/python'} 20:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:40 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 20:47:40 INFO - Cleaning up... 20:47:40 INFO - Return code: 0 20:47:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:47: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')]} 20:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47: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')]} 20:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:40 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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:40 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 20:47:40 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 20:47:40 INFO - Using env: {'DISPLAY': ':0', 20:47:40 INFO - 'HOME': '/home/cltbld', 20:47:40 INFO - 'LANG': 'en_US.UTF-8', 20:47:40 INFO - 'LANGUAGE': 'en_US:en', 20:47:40 INFO - 'LOGNAME': 'cltbld', 20:47:40 INFO - 'MAIL': '/var/mail/cltbld', 20:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:40 INFO - 'MOZ_NO_REMOTE': '1', 20:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:40 INFO - 'NO_EM_RESTART': '1', 20:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:40 INFO - 'PWD': '/builds/slave/test', 20:47:40 INFO - 'SHELL': '/bin/bash', 20:47:40 INFO - 'SHLVL': '1', 20:47:40 INFO - 'TERM': 'linux', 20:47:40 INFO - 'TMOUT': '86400', 20:47:40 INFO - 'USER': 'cltbld', 20:47:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:40 INFO - '_': '/tools/buildbot/bin/python'} 20:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:40 INFO - Downloading/unpacking psutil>=0.7.1 20:47:40 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 20:47:40 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 20:47:40 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 20:47:40 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 20:47:40 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 20:47:40 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 20:47:42 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:47:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:47:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:47:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:47:42 INFO - Installing collected packages: psutil 20:47:42 INFO - Running setup.py install for psutil 20:47:42 INFO - building 'psutil._psutil_linux' extension 20:47:42 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 20:47:43 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 20:47:43 INFO - building 'psutil._psutil_posix' extension 20:47:43 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 20:47:43 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 20:47:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:47:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:47:43 INFO - Successfully installed psutil 20:47:43 INFO - Cleaning up... 20:47:43 INFO - Return code: 0 20:47:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:43 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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:43 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 20:47:43 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 20:47:43 INFO - Using env: {'DISPLAY': ':0', 20:47:43 INFO - 'HOME': '/home/cltbld', 20:47:43 INFO - 'LANG': 'en_US.UTF-8', 20:47:43 INFO - 'LANGUAGE': 'en_US:en', 20:47:43 INFO - 'LOGNAME': 'cltbld', 20:47:43 INFO - 'MAIL': '/var/mail/cltbld', 20:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:43 INFO - 'MOZ_NO_REMOTE': '1', 20:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:43 INFO - 'NO_EM_RESTART': '1', 20:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:43 INFO - 'PWD': '/builds/slave/test', 20:47:43 INFO - 'SHELL': '/bin/bash', 20:47:43 INFO - 'SHLVL': '1', 20:47:43 INFO - 'TERM': 'linux', 20:47:43 INFO - 'TMOUT': '86400', 20:47:43 INFO - 'USER': 'cltbld', 20:47:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:43 INFO - '_': '/tools/buildbot/bin/python'} 20:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:47:43 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 20:47:43 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 20:47:43 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 20:47:43 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 20:47:43 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 20:47:43 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 20:47:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:47:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:47:45 INFO - Installing collected packages: mozsystemmonitor 20:47:45 INFO - Running setup.py install for mozsystemmonitor 20:47:45 INFO - Successfully installed mozsystemmonitor 20:47:45 INFO - Cleaning up... 20:47:45 INFO - Return code: 0 20:47:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:47:45 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')]} 20:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:45 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')]} 20:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:45 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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:45 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 20:47:45 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 20:47:45 INFO - Using env: {'DISPLAY': ':0', 20:47:45 INFO - 'HOME': '/home/cltbld', 20:47:45 INFO - 'LANG': 'en_US.UTF-8', 20:47:45 INFO - 'LANGUAGE': 'en_US:en', 20:47:45 INFO - 'LOGNAME': 'cltbld', 20:47:45 INFO - 'MAIL': '/var/mail/cltbld', 20:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:45 INFO - 'MOZ_NO_REMOTE': '1', 20:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:45 INFO - 'NO_EM_RESTART': '1', 20:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:45 INFO - 'PWD': '/builds/slave/test', 20:47:45 INFO - 'SHELL': '/bin/bash', 20:47:45 INFO - 'SHLVL': '1', 20:47:45 INFO - 'TERM': 'linux', 20:47:45 INFO - 'TMOUT': '86400', 20:47:45 INFO - 'USER': 'cltbld', 20:47:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:45 INFO - '_': '/tools/buildbot/bin/python'} 20:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:45 INFO - Downloading/unpacking blobuploader==1.2.4 20:47:45 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 20:47:45 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 20:47:45 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 20:47:45 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 20:47:45 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 20:47:45 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 20:47:47 INFO - Downloading blobuploader-1.2.4.tar.gz 20:47:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:47:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:47:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 INFO - Downloading docopt-0.6.1.tar.gz 20:47:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:47:48 INFO - Installing collected packages: blobuploader, requests, docopt 20:47:48 INFO - Running setup.py install for blobuploader 20:47:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:47:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:47:48 INFO - Running setup.py install for requests 20:47:48 INFO - Running setup.py install for docopt 20:47:48 INFO - Successfully installed blobuploader requests docopt 20:47:48 INFO - Cleaning up... 20:47:48 INFO - Return code: 0 20:47:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:47:48 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')]} 20:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:48 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')]} 20:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:48 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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:48 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 20:47:48 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 20:47:48 INFO - Using env: {'DISPLAY': ':0', 20:47:48 INFO - 'HOME': '/home/cltbld', 20:47:48 INFO - 'LANG': 'en_US.UTF-8', 20:47:48 INFO - 'LANGUAGE': 'en_US:en', 20:47:48 INFO - 'LOGNAME': 'cltbld', 20:47:48 INFO - 'MAIL': '/var/mail/cltbld', 20:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:48 INFO - 'MOZ_NO_REMOTE': '1', 20:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:48 INFO - 'NO_EM_RESTART': '1', 20:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:48 INFO - 'PWD': '/builds/slave/test', 20:47:48 INFO - 'SHELL': '/bin/bash', 20:47:48 INFO - 'SHLVL': '1', 20:47:48 INFO - 'TERM': 'linux', 20:47:48 INFO - 'TMOUT': '86400', 20:47:48 INFO - 'USER': 'cltbld', 20:47:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:48 INFO - '_': '/tools/buildbot/bin/python'} 20:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:47:48 INFO - Running setup.py (path:/tmp/pip-P0pTgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:47:48 INFO - Running setup.py (path:/tmp/pip-0s3fnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:47:48 INFO - Running setup.py (path:/tmp/pip-AI2YoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:47:49 INFO - Running setup.py (path:/tmp/pip-O3KlGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:47:49 INFO - Running setup.py (path:/tmp/pip-7DrCkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:47:49 INFO - Running setup.py (path:/tmp/pip-WetQmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:47:49 INFO - Running setup.py (path:/tmp/pip-I0DiV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:47:49 INFO - Running setup.py (path:/tmp/pip-OBXZFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:47:49 INFO - Running setup.py (path:/tmp/pip-nhaKvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:47:49 INFO - Running setup.py (path:/tmp/pip-s7ETt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:47:49 INFO - Running setup.py (path:/tmp/pip-2LoHSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:47:49 INFO - Running setup.py (path:/tmp/pip-uRCmCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:47:49 INFO - Running setup.py (path:/tmp/pip-w5gyXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:47:49 INFO - Running setup.py (path:/tmp/pip-XCji1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:47:49 INFO - Running setup.py (path:/tmp/pip-axN7yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:47:49 INFO - Running setup.py (path:/tmp/pip-D1_ntC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:47:49 INFO - Running setup.py (path:/tmp/pip-9Fzo5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:47:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:47:50 INFO - Running setup.py install for manifestparser 20:47:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Running setup.py install for mozcrash 20:47:50 INFO - Running setup.py install for mozdebug 20:47:50 INFO - Running setup.py install for mozdevice 20:47:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Running setup.py install for mozfile 20:47:50 INFO - Running setup.py install for mozhttpd 20:47:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Running setup.py install for mozinfo 20:47:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Running setup.py install for mozInstall 20:47:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:47:50 INFO - Running setup.py install for mozleak 20:47:50 INFO - Running setup.py install for mozlog 20:47:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:47:51 INFO - Running setup.py install for moznetwork 20:47:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:47:51 INFO - Running setup.py install for mozprocess 20:47:51 INFO - Running setup.py install for mozprofile 20:47:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:47:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:47:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:47:51 INFO - Running setup.py install for mozrunner 20:47:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:47:51 INFO - Running setup.py install for mozscreenshot 20:47:51 INFO - Running setup.py install for moztest 20:47:51 INFO - Running setup.py install for mozversion 20:47:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:47:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:47:51 INFO - Cleaning up... 20:47:51 INFO - Return code: 0 20:47:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:47: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')]} 20:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47: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')]} 20:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47: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', '-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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:51 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 20:47:51 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 20:47:51 INFO - Using env: {'DISPLAY': ':0', 20:47:51 INFO - 'HOME': '/home/cltbld', 20:47:51 INFO - 'LANG': 'en_US.UTF-8', 20:47:51 INFO - 'LANGUAGE': 'en_US:en', 20:47:51 INFO - 'LOGNAME': 'cltbld', 20:47:51 INFO - 'MAIL': '/var/mail/cltbld', 20:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:51 INFO - 'MOZ_NO_REMOTE': '1', 20:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:51 INFO - 'NO_EM_RESTART': '1', 20:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:51 INFO - 'PWD': '/builds/slave/test', 20:47:51 INFO - 'SHELL': '/bin/bash', 20:47:51 INFO - 'SHLVL': '1', 20:47:51 INFO - 'TERM': 'linux', 20:47:51 INFO - 'TMOUT': '86400', 20:47:51 INFO - 'USER': 'cltbld', 20:47:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:51 INFO - '_': '/tools/buildbot/bin/python'} 20:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:47:52 INFO - Running setup.py (path:/tmp/pip-N_Hc_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:47:52 INFO - Running setup.py (path:/tmp/pip-rTj80h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:47:52 INFO - Running setup.py (path:/tmp/pip-V3wf2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:47:52 INFO - Running setup.py (path:/tmp/pip-p6ivuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:47:52 INFO - Running setup.py (path:/tmp/pip-gQq_RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:47:52 INFO - Running setup.py (path:/tmp/pip-5MRCUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:47:52 INFO - Running setup.py (path:/tmp/pip-SBzXiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:47:52 INFO - Running setup.py (path:/tmp/pip-5tAjsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:47:52 INFO - Running setup.py (path:/tmp/pip-RsjjjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:47:52 INFO - Running setup.py (path:/tmp/pip-fGQMJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:47:52 INFO - Running setup.py (path:/tmp/pip-syN3UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:47:52 INFO - Running setup.py (path:/tmp/pip-Aekh4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:47:52 INFO - Running setup.py (path:/tmp/pip-Rkh46g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:47:52 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)) 20:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:47:52 INFO - Running setup.py (path:/tmp/pip-VaexSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:47:53 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)) 20:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:47:53 INFO - Running setup.py (path:/tmp/pip-9zf0SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:47:53 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)) 20:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:47:53 INFO - Running setup.py (path:/tmp/pip-JNki31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:47:53 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)) 20:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:47:53 INFO - Running setup.py (path:/tmp/pip-eGZs52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:47:53 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)) 20:47:53 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)) 20:47:53 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)) 20:47:53 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)) 20:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:47:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47:54 INFO - Downloading blessings-1.5.1.tar.gz 20:47:54 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 20:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:47:55 INFO - Installing collected packages: blessings 20:47:55 INFO - Running setup.py install for blessings 20:47:55 INFO - Successfully installed blessings 20:47:55 INFO - Cleaning up... 20:47:55 INFO - Return code: 0 20:47:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:47:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:47:55 INFO - Reading from file tmpfile_stdout 20:47:55 INFO - Current package versions: 20:47:55 INFO - argparse == 1.2.1 20:47:55 INFO - blessings == 1.5.1 20:47:55 INFO - blobuploader == 1.2.4 20:47:55 INFO - docopt == 0.6.1 20:47:55 INFO - manifestparser == 1.1 20:47:55 INFO - mozInstall == 1.12 20:47:55 INFO - mozcrash == 0.16 20:47:55 INFO - mozdebug == 0.1 20:47:55 INFO - mozdevice == 0.47 20:47:55 INFO - mozfile == 1.2 20:47:55 INFO - mozhttpd == 0.7 20:47:55 INFO - mozinfo == 0.9 20:47:55 INFO - mozleak == 0.1 20:47:55 INFO - mozlog == 3.1 20:47:55 INFO - moznetwork == 0.27 20:47:55 INFO - mozprocess == 0.22 20:47:55 INFO - mozprofile == 0.28 20:47:55 INFO - mozrunner == 6.11 20:47:55 INFO - mozscreenshot == 0.1 20:47:55 INFO - mozsystemmonitor == 0.0 20:47:55 INFO - moztest == 0.7 20:47:55 INFO - mozversion == 1.4 20:47:55 INFO - psutil == 3.1.1 20:47:55 INFO - requests == 1.2.3 20:47:55 INFO - wsgiref == 0.1.2 20:47:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:47:55 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')]} 20:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:55 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')]} 20:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:55 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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:55 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 20:47:55 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 20:47:55 INFO - Using env: {'DISPLAY': ':0', 20:47:55 INFO - 'HOME': '/home/cltbld', 20:47:55 INFO - 'LANG': 'en_US.UTF-8', 20:47:55 INFO - 'LANGUAGE': 'en_US:en', 20:47:55 INFO - 'LOGNAME': 'cltbld', 20:47:55 INFO - 'MAIL': '/var/mail/cltbld', 20:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:55 INFO - 'MOZ_NO_REMOTE': '1', 20:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:55 INFO - 'NO_EM_RESTART': '1', 20:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:55 INFO - 'PWD': '/builds/slave/test', 20:47:55 INFO - 'SHELL': '/bin/bash', 20:47:55 INFO - 'SHLVL': '1', 20:47:55 INFO - 'TERM': 'linux', 20:47:55 INFO - 'TMOUT': '86400', 20:47:55 INFO - 'USER': 'cltbld', 20:47:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:55 INFO - '_': '/tools/buildbot/bin/python'} 20:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 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)) 20:47:55 INFO - Cleaning up... 20:47:55 INFO - Return code: 0 20:47:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:47:55 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')]} 20:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:55 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')]} 20:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:55 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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:55 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 20:47:55 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 20:47:55 INFO - Using env: {'DISPLAY': ':0', 20:47:55 INFO - 'HOME': '/home/cltbld', 20:47:55 INFO - 'LANG': 'en_US.UTF-8', 20:47:55 INFO - 'LANGUAGE': 'en_US:en', 20:47:55 INFO - 'LOGNAME': 'cltbld', 20:47:55 INFO - 'MAIL': '/var/mail/cltbld', 20:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:55 INFO - 'MOZ_NO_REMOTE': '1', 20:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:55 INFO - 'NO_EM_RESTART': '1', 20:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:55 INFO - 'PWD': '/builds/slave/test', 20:47:55 INFO - 'SHELL': '/bin/bash', 20:47:55 INFO - 'SHLVL': '1', 20:47:55 INFO - 'TERM': 'linux', 20:47:55 INFO - 'TMOUT': '86400', 20:47:55 INFO - 'USER': 'cltbld', 20:47:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:55 INFO - '_': '/tools/buildbot/bin/python'} 20:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:55 INFO - Downloading/unpacking jsonschema 20:47:55 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 20:47:55 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 20:47:55 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 20:47:55 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 20:47:55 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 20:47:55 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 20:47:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:47:57 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 20:47:57 INFO - Downloading/unpacking functools32 (from jsonschema) 20:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:57 INFO - Downloading functools32-3.2.3-2.tar.gz 20:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:47:57 INFO - warning: no files found matching '*.txt' 20:47:57 INFO - no previously-included directories found matching 'build' 20:47:57 INFO - no previously-included directories found matching 'dist' 20:47:57 INFO - no previously-included directories found matching '.git*' 20:47:57 INFO - Installing collected packages: jsonschema, functools32 20:47:57 INFO - Running setup.py install for functools32 20:47:57 INFO - warning: no files found matching '*.txt' 20:47:57 INFO - no previously-included directories found matching 'build' 20:47:57 INFO - no previously-included directories found matching 'dist' 20:47:57 INFO - no previously-included directories found matching '.git*' 20:47:57 INFO - Successfully installed jsonschema functools32 20:47:57 INFO - Cleaning up... 20:47:58 INFO - Return code: 0 20:47:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:58 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 0x7fb7d832ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, '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': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', '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 20:47:58 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 20:47:58 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 20:47:58 INFO - Using env: {'DISPLAY': ':0', 20:47:58 INFO - 'HOME': '/home/cltbld', 20:47:58 INFO - 'LANG': 'en_US.UTF-8', 20:47:58 INFO - 'LANGUAGE': 'en_US:en', 20:47:58 INFO - 'LOGNAME': 'cltbld', 20:47:58 INFO - 'MAIL': '/var/mail/cltbld', 20:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:58 INFO - 'MOZ_NO_REMOTE': '1', 20:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:58 INFO - 'NO_EM_RESTART': '1', 20:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:58 INFO - 'PWD': '/builds/slave/test', 20:47:58 INFO - 'SHELL': '/bin/bash', 20:47:58 INFO - 'SHLVL': '1', 20:47:58 INFO - 'TERM': 'linux', 20:47:58 INFO - 'TMOUT': '86400', 20:47:58 INFO - 'USER': 'cltbld', 20:47:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:58 INFO - '_': '/tools/buildbot/bin/python'} 20:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:58 INFO - Downloading/unpacking flake8 20:47:58 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 20:47:58 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 20:47:58 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 20:47:58 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 20:47:58 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 20:47:58 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 20:47:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:47:59 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 20:47:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:48:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:48:00 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 20:48:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:00 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 20:48:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:48:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:48:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:48:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:48:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:48:00 INFO - no previously-included directories found matching 'docs/_build' 20:48:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:48:00 INFO - Running setup.py install for pep8 20:48:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:48:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:48:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:48:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:48:00 INFO - no previously-included directories found matching 'docs/_build' 20:48:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:48:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:48:00 INFO - Cleaning up... 20:48:00 INFO - Return code: 0 20:48:00 INFO - Running post-action listener: _resource_record_post_action 20:48:00 INFO - Running post-action listener: _start_resource_monitoring 20:48:00 INFO - Starting resource monitoring. 20:48:00 INFO - ##### 20:48:00 INFO - ##### Running install step. 20:48:00 INFO - ##### 20:48:00 INFO - Running pre-action listener: _resource_record_pre_action 20:48:00 INFO - Running main action method: install 20:48:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:48:01 INFO - Reading from file tmpfile_stdout 20:48:01 INFO - Detecting whether we're running mozinstall >=1.0... 20:48:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:48:01 INFO - Reading from file tmpfile_stdout 20:48:01 INFO - Output received: 20:48:01 INFO - Usage: mozinstall [options] installer 20:48:01 INFO - Options: 20:48:01 INFO - -h, --help show this help message and exit 20:48:01 INFO - -d DEST, --destination=DEST 20:48:01 INFO - Directory to install application into. [default: 20:48:01 INFO - "/builds/slave/test"] 20:48:01 INFO - --app=APP Application being installed. [default: firefox] 20:48:01 INFO - mkdir: /builds/slave/test/build/application 20:48:01 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'] 20:48:01 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 20:48:16 INFO - Reading from file tmpfile_stdout 20:48:16 INFO - Output received: 20:48:16 INFO - /builds/slave/test/build/application/firefox/firefox 20:48:16 INFO - Running post-action listener: _resource_record_post_action 20:48:16 INFO - ##### 20:48:16 INFO - ##### Running run-tests step. 20:48:16 INFO - ##### 20:48:16 INFO - Running pre-action listener: _resource_record_pre_action 20:48:16 INFO - Running main action method: run_tests 20:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:48:16 INFO - Python 2.7.3 20:48:16 INFO - Return code: 0 20:48:16 INFO - grabbing minidump binary from tooltool 20:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:16 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 0x1d743d0>, '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 0x1cdfed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce0360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:48:16 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 20:48:16 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 20:48:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:48:16 INFO - Return code: 0 20:48:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:48:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:48:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:48:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:48:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:48:17 INFO - Return code: 0 20:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:48:17 INFO - Using env: {'DISPLAY': ':0', 20:48:17 INFO - 'HOME': '/home/cltbld', 20:48:17 INFO - 'LANG': 'en_US.UTF-8', 20:48:17 INFO - 'LANGUAGE': 'en_US:en', 20:48:17 INFO - 'LOGNAME': 'cltbld', 20:48:17 INFO - 'MAIL': '/var/mail/cltbld', 20:48:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:48:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:17 INFO - 'MOZ_NO_REMOTE': '1', 20:48:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:17 INFO - 'NO_EM_RESTART': '1', 20:48:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:17 INFO - 'PWD': '/builds/slave/test', 20:48:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:48:17 INFO - 'SHELL': '/bin/bash', 20:48:17 INFO - 'SHLVL': '1', 20:48:17 INFO - 'TERM': 'linux', 20:48:17 INFO - 'TMOUT': '86400', 20:48:17 INFO - 'USER': 'cltbld', 20:48:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1451969246.958566-865673897', 20:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:17 INFO - '_': '/tools/buildbot/bin/python'} 20:48:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:48:17 INFO - mozversion application_buildid: 20160104202241 20:48:17 INFO - mozversion application_changeset: 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb 20:48:17 INFO - mozversion application_display_name: Nightly 20:48:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:48:17 INFO - mozversion application_name: Firefox 20:48:17 INFO - mozversion application_remotingname: firefox 20:48:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 20:48:17 INFO - mozversion application_vendor: Mozilla 20:48:17 INFO - mozversion application_version: 46.0a1 20:48:17 INFO - mozversion platform_buildid: 20160104202241 20:48:17 INFO - mozversion platform_changeset: 740ebb163d6fd390ab0d6ad0fcf2301706dd9bfb 20:48:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 20:48:17 INFO - mozversion platform_version: 46.0a1 20:48:17 INFO - using testdate: 1451969297 20:48:17 INFO - actual date: 1451969297 20:48:17 INFO - starting webserver on 'localhost:43841' 20:48:17 INFO - SUITE-START | Running 3 tests 20:48:17 INFO - TEST-START | dromaeo_css 20:48:17 INFO - operating with platform_type : linux_ 20:48:17 INFO - Initialising browser for dromaeo_css test... 20:48:18 INFO - TEST-INFO | started process 26747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAbsRX/profile http://localhost:43841/getInfo.html) 20:48:22 INFO - PROCESS | 26747 | __metrics Screen width/height:1600/1200 20:48:22 INFO - PROCESS | 26747 | colorDepth:24 20:48:22 INFO - PROCESS | 26747 | Browser inner width/height: 1024/697 20:48:22 INFO - PROCESS | 26747 | __metrics 20:48:22 INFO - PROCESS | 26747 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:48:22 INFO - PROCESS | 26747 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:48:23 INFO - TEST-INFO | 26747: exit 0 20:48:23 INFO - Browser initialized. 20:48:23 INFO - Running cycle 1/1 for dromaeo_css test... 20:48:23 INFO - TEST-INFO | started process 26842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAbsRX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:48:35 INFO - PROCESS | 26842 | RSS: Main: 150642688 20:48:35 INFO - PROCESS | 26842 | 20:49:26 INFO - PROCESS | 26842 | 1451969366805 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] 20:51:38 INFO - PROCESS | 26842 | Cycle 1(1): loaded http://localhost:43841/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43841/tests/dromaeo/cssquery-ext.html) 20:51:40 INFO - PROCESS | 26842 | RSS: Main: 253304832 20:51:40 INFO - PROCESS | 26842 | 20:54:42 INFO - PROCESS | 26842 | Cycle 1(1): loaded http://localhost:43841/tests/dromaeo/cssquery-ext.html (next: http://localhost:43841/tests/dromaeo/cssquery-jquery.html) 20:54:43 INFO - PROCESS | 26842 | RSS: Main: 231784448 20:54:43 INFO - PROCESS | 26842 | 20:57:45 INFO - PROCESS | 26842 | Cycle 1(1): loaded http://localhost:43841/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43841/tests/dromaeo/cssquery-mootools.html) 20:57:45 INFO - PROCESS | 26842 | RSS: Main: 227717120 20:57:45 INFO - PROCESS | 26842 | 21:00:47 INFO - PROCESS | 26842 | Cycle 1(1): loaded http://localhost:43841/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43841/tests/dromaeo/cssquery-prototype.html) 21:00:48 INFO - PROCESS | 26842 | RSS: Main: 210558976 21:00:48 INFO - PROCESS | 26842 | 21:03:51 INFO - PROCESS | 26842 | Cycle 1(1): loaded http://localhost:43841/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43841/tests/dromaeo/cssquery-yui.html) 21:03:51 INFO - PROCESS | 26842 | RSS: Main: 218112000 21:03:51 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | Cycle 1(1): loaded http://localhost:43841/tests/dromaeo/cssquery-yui.html (next: http://localhost:43841/tests/dromaeo/cssquery-dojo.html) 21:06:54 INFO - PROCESS | 26842 | RSS: Main: 260096000 21:06:54 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | __start_tp_report 21:06:54 INFO - PROCESS | 26842 | _x_x_mozilla_page_load 21:06:54 INFO - PROCESS | 26842 | _x_x_mozilla_page_load_details 21:06:54 INFO - PROCESS | 26842 | |i|pagename|runs| 21:06:54 INFO - PROCESS | 26842 | |0;dojo.html;2595.9351016224596;2688.6101515280284;2691.031228757648;2703.7972152088587;2723.591461280808;4404.29531274996;4536.795844187011;4599.379083823683;4601.562851529104;4616.938104236024;4542.500324964251;4552.817887284505;4608.516105808883;4621.71888863412;4628.236341003731;4188.832446702128;4208.97895510522;4277.144571085788;4336.392904993303;4348.130373925212;4052.3111071117833;4298.16185843759;4345.109252603224;4360.25875601147;4382.211201983641;4192.916141677149;4199.286121359376;4259.297215959363;4293.119910418357;4330.155619654169;4240.830366785325;4247.256730072256;4249.830006799724;4287.099709061101;4288.0351920817875;4033.193361327717;4227.154569086164;4248.4052232687445;4248.957510424887;4283.721558098714;4433.312836510314;4441.533638967894;4451.821927122911;4563.840265590688;4594.448666160049;4914.0908931847725;4953.801847926079;4955.405351357824;4958.454569997298;4991.850244492671;4729.314249433847;4964.230544265644;4970.726610036447;4973.403191617029;4975.651704380694;4450.221211288012;4464.15181115587;4515.864524064284;4548.681592288508;4606.355110284563;5005.524475174852;5008.799648014112;5010.749462526859;5014.674046186986;5061.240813877874;4635.420572428447;4826.638002149783;4834.734089625034;4837.05677392912;4838.371011768448;4795.232762758012;4814.398200224972;4893.119238537026;4991.376077990251;5002.299678045077;4870.318155458239;4877.975610121997;4878.390201224847;4896.902061958812;4927.95072049282;4859.125357435695;4859.902801943941;4867.878303042452;4871.756412179448;4920.655554111249;4033.616806403387;4115.300398932189;4132.938005929914;4133.607307305801;4166.208420400114;3652.251288485854;3656.140806910374;3672.485851980725;3695.870644527429;3699.741018128705;4241.088166044316;4241.63946064588;4241.681873859473;4272.893177670521;4283.785810709514;4656.254999200111;4823.807047718122;4824.734639594856;4843.709377437365;4931.309616653672;4227.492700875853;4236.745795252295;4245.787710614457;4268.701190916669;4274.5939135782055;4415.823367065282;4429.269170586817;4430.269005614037;4435.3125265583885;4470.195364834361;4474.284114541658;4578.702384345007;4584.954150458453;4616.26139817641;4741.857744267678;4948.38145231846;4950.257461380822;4976.154053810933;4976.427710813158;4997.9500204997485;4699.600533954652;4699.694519856198;4702.835400761094;4737.928931066106;4743.549362810528;4609.400777898852;4715.151272770797;4717.834875779331;4793.760311984317;4894.045661096052;4908.558229759339;4908.680935739309;4911.410630724193;4928.433230178575;4944.975275123601;4762.380890484214;4763.356946812136;4765.285207218945;4768.356271903249;4805.087033463631;4546.068056048568;4651.558101980307;4653.952860606337;4769.809207631656;4809.831655892027;4623.491415944311;4689.742064186366;4694.600958918393;4705.317728929354;4729.337892694956;4821.156297647968;4821.614270858253;4824.252240902666;4848.5636292733825;4858.659893807399;4570.085982803386;4638.6752927294765;4674.252119660974;4729.8108075677965;4769.95230047709 21:06:54 INFO - PROCESS | 26842 | |1;ext.html;499.02191704259644;506.3417557175671;518.5877227604054;529.2352550564435;562.4600383631711;24486.87756561217;24883;24900.377490562743;24927.626085608732;31752.523712144277;34583.4812477813;35062.824685876534;35081.649183508154;35203.82398088012;35254.64745352546;7653.808654783619;7828.099768526636;7833.216678332178;7835.6473958671995;7841;6983.511154219207;7163.498555101145;7636.770896873103;9955.651552195675;10274.178065754759;9735.805283894319;9814.067663571985;9825.4104753715;9825.90174098257;9828.852567211497;7043.68303426347;9830.164436022947;9922.156616687591;9947.055029772197;9971.351862128939;6711.832204194885;9744.171745401649;9954.552045157985;9961.950190249003;9962;32687.836560817283;32853.17867053319;33067.83466082654;33070.669293307;33073;2301.2635956493928;2384.9046038158453;2440.7681270279295;2485.3538080099124;2580.600006998918;22618;23028;23051.654225186634;23176.420589485228;27193;3012.9096127116222;3081.445339838828;3100.922476938072;3138.4821504451966;3224.1456014156265;223896;224327;224741;225914;226137;47735.5226447738;49242.75378623084;50539.73650658763;50883.49116508788;51349.74325128425;54552;55486.16770748442;55652;55691.72154139284;55735.163972540446;9794.853077203848;9867.210623150131;9905.950470247602;9928;9945.751356216153;7682.423818213656;7763.301302882767;7786.065672119382;7787.260210280015;7789.143194248628;14310.356033978496;14371;14410.639734006734;14440;14562.271886405637;6848.417884479775;7071.720605634006;7143.392811610967;7217.7473788417155;7255.419566434673;758.9051368578928;776.4681193382438;935.209747763139;973.5035132082688;991.7371896447447;25769.742302576735;25949.61075583868;26012.349691257492;26046;26184.8690756545;894.4633220067907;902.873597696323;903.9683611073581;993.9712397668378;1009.5255230041869;13113.409896554678;13412.195268283738;13680;14344.354504047344;14366.712665746627;263417;265806;267856;267883;269373;37080;37344.43983340252;37393.06517337088;37421.43867841984;37447.25105497875;1114.5820317380983;1129.2885482146196;1129.76274982253;1137.0392018744149;1139.0773473486668;20519;21245.46886327854;21250.78749212488;21464.356069317946;23394.415139621644;35345.823270883484;36224;40277.39583906302;41215;41256.174876501704;164450;165630;166857;166978;167069;23610.645840312067;24189.879050604635;24198;25589.232323030337;26057.609135863357;26203.475930481665;26366;28781.85609071941;31287.217819554695;34989.650103498636;29556;29746;30356.392872142875;30699.539506907862;30715;30163.245918852204;30376.392472150874;30521.847390762905;30618.540721888745;30684;29278.26804329909;30700;30731.2317192072;30750.38499229958;33304.666953330154;27697;28082.438351233268;29227.7077229225;29662.258443539085;29751.851240743657;20690.793092068885;20973.370798876058;21010.159593616696;21807.23674671379;21875 21:06:54 INFO - PROCESS | 26842 | |2;jquery.html;325.65317936397724;327.2505961348512;328.4941190566528;328.6926723513514;335.4180496837987;12332.4450399732;12781.424835882384;14594.70810583789;15074.623134421645;16027.118508482028;12547;12634.936825315883;12885.355732213398;12891.162074465154;13019.283939383331;4865.318855360252;4997.850064498062;5119.12974794284;5135.691858488484;5136.101182293102;3489.755717099804;3608.7293452991;4977.6266779991465;5011.799528018875;5201.271821944912;5152.304438900756;5161.7161056141895;5165.354330708661;5180.870478238036;5187.584993200554;5028.7737051832755;5143.485651434864;5682.51698605619;5758.798442054508;5773.797917072882;5194.92207616886;5209.739513024334;5210.140326846066;5211.140161873286;5214.582833373321;11071.339299105119;11719.121065920004;11862.644120676394;11871.703207419883;11874.0500759939;1698.498942811861;1751.5708651380367;1830.4508647405726;1845.769278840145;1881.868269221155;9002.549872506348;9016.77458063547;9091.136342047495;10491.213159013105;12509;1563.7341651919087;1629.08771088191;1635.2314412226235;1694.9406770763087;1709.905955172465;54086.18870716942;55432.16851747227;55495.44504554943;56253.156202656995;57441.13838292429;9109.180173784258;9479.810403792024;9749.65876194344;9750.317477776629;9808.411495310162;12494.75010499785;12520.373981300898;12521.56174533887;12526.060545458944;12535.122541422195;5685.772569097273;5862.062070068769;5894.145348924382;6057.3336932937345;6092.695365231721;5565.1095824667855;5575.107982722745;5609.551235901118;5645.350784659735;5670;4093.467849179647;4164.083901541656;4212.810423530948;4232.576742325804;4252.170826688766;1586.7461206206951;1623.131624580867;1676.2121802752931;1694.7203711387729;1700.1329322045847;765.3915137465729;805.2390490985962;810.805406702399;837.8324335132997;877.8946526416743;14741.705165896621;15372;15547.844521554865;15700.371985120695;16141.273642686107;712.5795780489433;713.9901178183501;780.0678189563417;808.6805711743946;810.7689308547153;8110.472819266729;8123.878141827878;8176.264136227649;8392.076871544125;8479.321654267644;121474;122007.38996304962;122062.38968805276;122107.38946305211;122400;68115.3188468109;69397;72168.27831721616;72534.55990800711;73459;1015.0610685116238;1031.4275577054807;1036.7874585709912;1040.9687709368732;1042.0413219837767;12671.669474705022;13087.345632718136;13129.803052954405;13147.211167329991;13245.867541324464;29839.254018649706;29918.551221732127;29928.850355748084;30441.391172176875;30888.227794305323;43516.56483435125;44862.3270650947;45069;47151.29273060838;47358.05283894372;8532.658693652184;8650;8758.03661597211;9054.049324821062;9064.592093355683;15513.22433878279;15973.201339932724;15994.120323382325;16001.359945602046;16229.188540573161;12415.689607759878;12416.75166496683;12587.622371328875;13791.724165516835;13956.581302560939;12496.500139994298;13030.153040052366;13373.866261337262;13384.397702103623;13501.527446539323;12464.937675311565;12945.223286602833;12980.675483112998;12986.675333116369;13238.602841914759;7990.92009079925;8670.696525621574;9084.727458176265;9095.727128186165;9114.954425227832;9271.582778774837;9369.812603748023;11403;12969.935150324189;13378.9331053348 21:06:54 INFO - PROCESS | 26842 | |3;mootools.html;1210.8365370674956;1290.1420555330706;1362.93185340733;1433.6702558411564;1663.3679201903283;5829.32962709288;6263.31103578606;6332.208473940757;6337.207849018872;6371.235451745792;6402.519811014169;6591.571547849387;6600.735970561183;6602.844502212106;6609.867802643944;1989.8209161175455;2026.6048120616485;2028.3002364184406;2028.6145632329883;2029.4926268432891;2027.290448343083;2042.765082015565;2051.9897400512978;2071.513194399315;2080.3966849613594;1988.8607797454183;1995.9101840417215;2023.109831674066;2023.2008356699096;2024.1397406102421;2016.5563576013253;2027.6147531968952;2030.6446371885008;2037.847161462896;2041.387583724884;1987.0859404673722;2030.157484643871;2050.138941644498;2054.291269512031;2055.7841426650134;6567.704453299613;6649.135612370409;6649.135612370409;6650.434713049397;6671.566348187353;3850.537935447764;3921.274564205631;3921.7058720595783;3927.19492504036;3929.292727309083;2569.2677586887835;2593.07945679283;2632.921012369632;2664.640273563083;2689.099151784155;805.907320658126;809.5102463009853;821.6220538552274;833.2584000239731;833.4874052457756;9240.722778316662;9270.49012304323;9274.350795444321;9278.72163835086;9281.257499400099;3729.1236559408517;3742.326381251401;3750.1749615084636;3800.7339486235696;3801.7148713846573;7901.604919754104;7903.525788452711;7918.28735413804;7922.445428819928;7923.088844782924;3851.9614803852164;3854;3859.073822282688;3863.343231650626;3872.9806350968065;3046.466868298083;3121.6254049514205;3538.5046093546925;3549.4143466328283;3554.129238336624;3151.023182813289;3155.1323386069016;3161.0832858470785;3170.4927211646027;3208.5668434761474;1011.0445628880784;1030.0677886512717;1032.4734385463319;1037.190991027;1037.3205550364373;924.3298608508777;933.5892207428709;949.7103383468109;949.7483166960761;951.2247518272586;6048.818535443944;6187.597806142587;6197.318294987548;6197.96901015492;6207.068939658997;979.588572799426;1053.942033188182;1068.2415485005733;1075.693427373195;1076.499427766077;4646.279826626878;4657.976710116428;4713.882152946204;4716.504766999485;4726.243800991825;8155.184481551916;8209.343252539782;8313.667453301921;8491.405601607952;8502.574871256413;8349.707760228484;8374.036985746596;8386.87419688705;8405.075441701409;8453.661853525913;5916.55625828056;5971.104334349882;6057.666828324484;6089.512838972872;6095.146679464879;5981.700914954322;6002.219711437485;6002.789902353396;6010.188624535632;6013.819585412444;7575.962120189364;7726.304632583095;7747.334323120556;7769.456138070281;7777.144514103557;7725.266099720518;7898.407619428681;7919;7931;8051;4819.855404337875;4932.062908047459;5548.528375088163;5620.522255608319;5622.690752008679;6012.609180403435;6124.265088189446;6150.7539698411565;6155.2921414037955;6158.476529495043;5761.942380576141;5826.300843898759;5833.883322333614;5849.327327357409;5978.252718410199;5789.45000224978;5823.505002074871;5884;5886.58793884424;5891.970540147443;5660.066089095418;5702.515286200553;5705.258316418839;5718.085106383125;5729;5523.502884740393;5525.4474552544425;5547.472990065938;5552.50027497511;5574.219609254626;5622.578306626938;5637.126245431965;5646.943530564642;5656.43435656431;5662.235598194191 21:06:54 INFO - PROCESS | 26842 | |4;prototype.html;285.86992918222205;290.33368419477296;293.6842893889069;296.7166356129896;298.4240415997125;5323.307969963899;5381.165919282513;5409.810656627019;5457.017736807373;5504.889902201953;5318.282031925699;5343.171808369709;5362.168863826113;5368.677879327233;5401.891962160755;4147.212029714345;4147.626713595776;4149.481314835645;4152.1280531088505;4153.356229784388;3827.5789663137034;3898.9025274368228;4004.0790618157694;4079.0822065035427;4079.938800917989;4054.776987265699;4067;4080.6123418275215;4084.65280451162;4086.3870419437176;3807.257584770971;3883.37865941448;4071.1654110907193;4081.10215752534;4089.8159582818694;3411.692947634725;3482.9303413931834;3488.773229740059;3490.406630872758;3491.965080349215;5145.588352931756;5160.741962901878;5161.27742116104;5173.9741301293625;5190.11767999441;4642.187617166982;4646.674732768707;4653.139169253699;4653.627709783209;4654.325122857201;5455.372632147314;5604.943950560483;5611.446791709763;5621.072523033695;5632.408597097327;3793.070697679086;3796.5823759386444;3798.6391292827416;3800.5439347278225;3801.657850793414;5842.532597392198;5925.31858836235;5927.614705044201;5932.9406705932815;5933.703314834284;3951.68386529077;3953.2488827122756;3954.8220330085214;3955.584663610337;3961.8217180226957;4009.919801603952;4014.6186112319283;4016.036151323661;4018.1361007383553;4018.8794336169963;4465.754383508938;4591.8392856249875;4657.673962822638;4668;4668.976655116703;5638.238837756932;5646.802361917313;5649;5651.519620832193;5653.095504719226;1381.5026590427437;1388.2434073430004;1390.4577214886203;1390.8122403475604;1391.1166409330149;927.2952556057445;934.303943562037;936.0452338614575;957.8467445208734;959.6881013670585;4933.432655244621;4947.505249475023;4948.529889660476;4956.628252881048;4958.479359667255;5876.118582212703;5880.088586269135;5883.0881213411985;5883.294004719375;5889.381614930457;4939.802407903644;4946.332245146859;4950.356453661001;4950.777215025332;4952.62855285855;3036.1802313375265;3063.341381602966;3119.9376012479624;3142.591463109781;3151.9684803152136;5439.456054394529;5455.809046683347;5580.832575022756;5586.804461843816;5607.102863541813;6032.939670603238;6046.093086037042;6056.273247210363;6068;6069.757209711651;5535.169724541351;5586.636868603528;5587.189857470644;5590.161475778666;5595.860103497445;5705;5883.058710606282;5925.496332811759;5947.524198064058;5956.434138756811;5727.68497732612;5755.856103597276;5790.247267855152;5794.2177805997335;5812.953668339739;5559.11054231321;5588.6646801192055;5595.440455954372;5599.580031497735;5608.130739735348;3937.8818635440985;4029.798510074426;4075.4090656855183;4075.8369665214245;4077.5310839253866;5882.323532793784;5904.852378690567;5907.940920590739;5908.202392676933;5910.408959104056;5680.7443665036;5682.176084467812;5686.77252909879;5694.1458781183155;5695.544356451557;5684;5685.403032681675;5687.544996400361;5698.145278208136;5706.771729130788;5420.539254163283;5536.390996990408;5536.446355364431;5574.414686457863;5586.636868603528;5682.886342273048;5684.431556844283;5684.77260909559;5689.573282003784;5696.174054762119;5549.805756798492;5561.748606563491;5564.91652625219;5567.24842146305;5569.498745112959 21:06:54 INFO - PROCESS | 26842 | |5;yui.html;544.2706772924283;554.0995881692251;630.7445484578748;631.5894668465497;663.6250518457068;9297.907020929797;9528.190103841182;9548.904510954888;9552.474613896251;9560.235181185497;9732.854007189897;10447.791044179112;10619.946900265508;10623.52194151263;10628.256022078438;734.2107234722681;750.3322043381395;750.8010377250006;751.2712668711341;752.2665401233808;731.7585196885042;737.4137560639305;739.6634531288278;739.6634531288278;740.097081560498;776.7863837444692;785.1873311122989;787.1695361393756;787.4684587903171;787.9803004924865;768.8731359325704;769.796004058922;770.96916123355;774.7830607429929;779.0456690554055;572.481903876992;574.2678085441054;575.5338176077349;577.5466258986676;578;9291.48896810675;9427.104425079606;9428.905710942872;9435.575399107056;9436.764080897963;8544.829103417958;8687.3050155988;8904.154105359981;8972.910270897339;9360.063993600654;7761.883571746428;7969.203079692043;8225.506469611842;8249.422540422172;8249.587520624005;2631.6184153297854;2636.4068084680985;2656.628072069912;2687.0192379781433;2687.705220715188;31600.841995789873;32861.83569082139;37022.81488592567;37178.628213717784;40945.59054409448;8223.342132629376;8240;8295.092128810407;8433.19884610961;8506.74479765608;14132.222727749866;14164;14173.291335433187;14175.078619889675;14186.645333866529;5806.767729290866;5857.502112320415;5918.408159184047;5989.431004054608;6002.639841609517;3225.854836532362;3253.089135042192;3383.7293016558615;3395.932081358359;3400.0479865637662;2451.2768733223743;2480.838745481538;2482.5779617465073;2484.1926373928186;2484.67699199103;432.41623807859764;438.53077207387787;449.9685022048491;450.96843220974876;455.640044364948;360.80696827197846;471.3683663890335;472.94505374149264;474.6178337651054;509.0480800902262;6755.189377274758;7038.577685338896;7126.964365178141;8015.919840801634;8124.431289809657;380.55094987913975;418.101082672251;432.63658526837605;438.5592479558024;513.6609837507302;3165.572647692532;3264;3285.6221534523356;3306.272620023591;3328.783629064103;47253.29120063202;49464;49600.751996239786;49654.25518617224;49677.50322496729;42775.35836962448;43339.56660433355;43445.131097377875;43472.565274347486;43607;34696.82651586776;43759.78120109379;43823.34264986028;43971.34042989358;45328.77335613301;7569.205233450409;7590;7712.5758083305955;7758.3017528422715;7901.802454938443;25825.225243242734;27091.72908270892;29755.851220743756;30216.395672086874;30751.077467676005;38281.234375312895;40892.59107408888;41209.38185927273;41647;42011.579884200764;9260.212881905114;9293.953530232306;9359.532023398939;9415.81168376615;9589.472579008221;10131.544080516542;10280.434576098087;10396.896031039592;10460.738481538023;10500.443708807334;9930.354526955725;9945.751356216153;9962.651307204213;10198.133158681298;10199.184065274612;9702.805943881223;9847.310688251753;9911.900880991097;9919;9931.602735890483;10021.048000439947;10024.097831195228;10046.899531004596;10098.697039088838;10184.236182286506;7673.462857599914;8046.758597242092;8376.49741015541;8421.70524031656;8446.493210407396;7544.698212071456;7776.727814526691;7960;8054.073781515201;8132.715354962548 21:06:54 INFO - PROCESS | 26842 | __end_tp_report 21:06:54 INFO - PROCESS | 26842 | __start_cc_report 21:06:54 INFO - PROCESS | 26842 | _x_x_mozilla_cycle_collect,974 21:06:54 INFO - PROCESS | 26842 | __end_cc_report 21:06:54 INFO - PROCESS | 26842 | __startTimestamp1451970414455__endTimestamp 21:06:54 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | ------- Summary: start ------- 21:06:54 INFO - PROCESS | 26842 | Number of tests: 6 21:06:54 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | [#0] dojo.html Cycles:165 Average:4534.60 Median:4628.24 stddev:453.59 (9.8%) stddev-sans-first:428.73 21:06:54 INFO - PROCESS | 26842 | Values: 2595.9 2688.6 2691.0 2703.8 2723.6 4404.3 4536.8 4599.4 4601.6 4616.9 4542.5 4552.8 4608.5 4621.7 4628.2 4188.8 4209.0 4277.1 4336.4 4348.1 4052.3 4298.2 4345.1 4360.3 4382.2 4192.9 4199.3 4259.3 4293.1 4330.2 4240.8 4247.3 4249.8 4287.1 4288.0 4033.2 4227.2 4248.4 4249.0 4283.7 4433.3 4441.5 4451.8 4563.8 4594.4 4914.1 4953.8 4955.4 4958.5 4991.9 4729.3 4964.2 4970.7 4973.4 4975.7 4450.2 4464.2 4515.9 4548.7 4606.4 5005.5 5008.8 5010.7 5014.7 5061.2 4635.4 4826.6 4834.7 4837.1 4838.4 4795.2 4814.4 4893.1 4991.4 5002.3 4870.3 4878.0 4878.4 4896.9 4928.0 4859.1 4859.9 4867.9 4871.8 4920.7 4033.6 4115.3 4132.9 4133.6 4166.2 3652.3 3656.1 3672.5 3695.9 3699.7 4241.1 4241.6 4241.7 4272.9 4283.8 4656.3 4823.8 4824.7 4843.7 4931.3 4227.5 4236.7 4245.8 4268.7 4274.6 4415.8 4429.3 4430.3 4435.3 4470.2 4474.3 4578.7 4585.0 4616.3 4741.9 4948.4 4950.3 4976.2 4976.4 4998.0 4699.6 4699.7 4702.8 4737.9 4743.5 4609.4 4715.2 4717.8 4793.8 4894.0 4908.6 4908.7 4911.4 4928.4 4945.0 4762.4 4763.4 4765.3 4768.4 4805.1 4546.1 4651.6 4654.0 4769.8 4809.8 4623.5 4689.7 4694.6 4705.3 4729.3 4821.2 4821.6 4824.3 4848.6 4858.7 4570.1 4638.7 4674.3 4729.8 4770.0 21:06:54 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | [#1] ext.html Cycles:180 Average:36329.40 Median:17194.07 stddev:58322.10 (339.2%) stddev-sans-first:58423.66 21:06:54 INFO - PROCESS | 26842 | Values: 499.0 506.3 518.6 529.2 562.5 24486.9 24883.0 24900.4 24927.6 31752.5 34583.5 35062.8 35081.6 35203.8 35254.6 7653.8 7828.1 7833.2 7835.6 7841.0 6983.5 7163.5 7636.8 9955.7 10274.2 9735.8 9814.1 9825.4 9825.9 9828.9 7043.7 9830.2 9922.2 9947.1 9971.4 6711.8 9744.2 9954.6 9962.0 9962.0 32687.8 32853.2 33067.8 33070.7 33073.0 2301.3 2384.9 2440.8 2485.4 2580.6 22618.0 23028.0 23051.7 23176.4 27193.0 3012.9 3081.4 3100.9 3138.5 3224.1 223896.0 224327.0 224741.0 225914.0 226137.0 47735.5 49242.8 50539.7 50883.5 51349.7 54552.0 55486.2 55652.0 55691.7 55735.2 9794.9 9867.2 9906.0 9928.0 9945.8 7682.4 7763.3 7786.1 7787.3 7789.1 14310.4 14371.0 14410.6 14440.0 14562.3 6848.4 7071.7 7143.4 7217.7 7255.4 758.9 776.5 935.2 973.5 991.7 25769.7 25949.6 26012.3 26046.0 26184.9 894.5 902.9 904.0 994.0 1009.5 13113.4 13412.2 13680.0 14344.4 14366.7 263417.0 265806.0 267856.0 267883.0 269373.0 37080.0 37344.4 37393.1 37421.4 37447.3 1114.6 1129.3 1129.8 1137.0 1139.1 20519.0 21245.5 21250.8 21464.4 23394.4 35345.8 36224.0 40277.4 41215.0 41256.2 164450.0 165630.0 166857.0 166978.0 167069.0 23610.6 24189.9 24198.0 25589.2 26057.6 26203.5 26366.0 28781.9 31287.2 34989.7 29556.0 29746.0 30356.4 30699.5 30715.0 30163.2 30376.4 30521.8 30618.5 30684.0 29278.3 30700.0 30731.2 30750.4 33304.7 27697.0 28082.4 29227.7 29662.3 29751.9 20690.8 20973.4 21010.2 21807.2 21875.0 21:06:54 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | [#2] jquery.html Cycles:180 Average:15703.59 Median:3549.24 stddev:23507.33 (662.3%) stddev-sans-first:23544.92 21:06:54 INFO - PROCESS | 26842 | Values: 325.7 327.3 328.5 328.7 335.4 12332.4 12781.4 14594.7 15074.6 16027.1 12547.0 12634.9 12885.4 12891.2 13019.3 4865.3 4997.9 5119.1 5135.7 5136.1 3489.8 3608.7 4977.6 5011.8 5201.3 5152.3 5161.7 5165.4 5180.9 5187.6 5028.8 5143.5 5682.5 5758.8 5773.8 5194.9 5209.7 5210.1 5211.1 5214.6 11071.3 11719.1 11862.6 11871.7 11874.1 1698.5 1751.6 1830.5 1845.8 1881.9 9002.5 9016.8 9091.1 10491.2 12509.0 1563.7 1629.1 1635.2 1694.9 1709.9 54086.2 55432.2 55495.4 56253.2 57441.1 9109.2 9479.8 9749.7 9750.3 9808.4 12494.8 12520.4 12521.6 12526.1 12535.1 5685.8 5862.1 5894.1 6057.3 6092.7 5565.1 5575.1 5609.6 5645.4 5670.0 4093.5 4164.1 4212.8 4232.6 4252.2 1586.7 1623.1 1676.2 1694.7 1700.1 765.4 805.2 810.8 837.8 877.9 14741.7 15372.0 15547.8 15700.4 16141.3 712.6 714.0 780.1 808.7 810.8 8110.5 8123.9 8176.3 8392.1 8479.3 121474.0 122007.4 122062.4 122107.4 122400.0 68115.3 69397.0 72168.3 72534.6 73459.0 1015.1 1031.4 1036.8 1041.0 1042.0 12671.7 13087.3 13129.8 13147.2 13245.9 29839.3 29918.6 29928.9 30441.4 30888.2 43516.6 44862.3 45069.0 47151.3 47358.1 8532.7 8650.0 8758.0 9054.0 9064.6 15513.2 15973.2 15994.1 16001.4 16229.2 12415.7 12416.8 12587.6 13791.7 13956.6 12496.5 13030.2 13373.9 13384.4 13501.5 12464.9 12945.2 12980.7 12986.7 13238.6 7990.9 8670.7 9084.7 9095.7 9115.0 9271.6 9369.8 11403.0 12969.9 13378.9 21:06:54 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | [#3] mootools.html Cycles:180 Average:4665.55 Median:5703.89 stddev:2443.17 (42.8%) stddev-sans-first:2436.23 21:06:54 INFO - PROCESS | 26842 | Values: 1210.8 1290.1 1362.9 1433.7 1663.4 5829.3 6263.3 6332.2 6337.2 6371.2 6402.5 6591.6 6600.7 6602.8 6609.9 1989.8 2026.6 2028.3 2028.6 2029.5 2027.3 2042.8 2052.0 2071.5 2080.4 1988.9 1995.9 2023.1 2023.2 2024.1 2016.6 2027.6 2030.6 2037.8 2041.4 1987.1 2030.2 2050.1 2054.3 2055.8 6567.7 6649.1 6649.1 6650.4 6671.6 3850.5 3921.3 3921.7 3927.2 3929.3 2569.3 2593.1 2632.9 2664.6 2689.1 805.9 809.5 821.6 833.3 833.5 9240.7 9270.5 9274.4 9278.7 9281.3 3729.1 3742.3 3750.2 3800.7 3801.7 7901.6 7903.5 7918.3 7922.4 7923.1 3852.0 3854.0 3859.1 3863.3 3873.0 3046.5 3121.6 3538.5 3549.4 3554.1 3151.0 3155.1 3161.1 3170.5 3208.6 1011.0 1030.1 1032.5 1037.2 1037.3 924.3 933.6 949.7 949.7 951.2 6048.8 6187.6 6197.3 6198.0 6207.1 979.6 1053.9 1068.2 1075.7 1076.5 4646.3 4658.0 4713.9 4716.5 4726.2 8155.2 8209.3 8313.7 8491.4 8502.6 8349.7 8374.0 8386.9 8405.1 8453.7 5916.6 5971.1 6057.7 6089.5 6095.1 5981.7 6002.2 6002.8 6010.2 6013.8 7576.0 7726.3 7747.3 7769.5 7777.1 7725.3 7898.4 7919.0 7931.0 8051.0 4819.9 4932.1 5548.5 5620.5 5622.7 6012.6 6124.3 6150.8 6155.3 6158.5 5761.9 5826.3 5833.9 5849.3 5978.3 5789.5 5823.5 5884.0 5886.6 5892.0 5660.1 5702.5 5705.3 5718.1 5729.0 5523.5 5525.4 5547.5 5552.5 5574.2 5622.6 5637.1 5646.9 5656.4 5662.2 21:06:54 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | [#4] prototype.html Cycles:180 Average:4661.24 Median:5391.53 stddev:1407.15 (26.1%) stddev-sans-first:1372.24 21:06:54 INFO - PROCESS | 26842 | Values: 285.9 290.3 293.7 296.7 298.4 5323.3 5381.2 5409.8 5457.0 5504.9 5318.3 5343.2 5362.2 5368.7 5401.9 4147.2 4147.6 4149.5 4152.1 4153.4 3827.6 3898.9 4004.1 4079.1 4079.9 4054.8 4067.0 4080.6 4084.7 4086.4 3807.3 3883.4 4071.2 4081.1 4089.8 3411.7 3482.9 3488.8 3490.4 3492.0 5145.6 5160.7 5161.3 5174.0 5190.1 4642.2 4646.7 4653.1 4653.6 4654.3 5455.4 5604.9 5611.4 5621.1 5632.4 3793.1 3796.6 3798.6 3800.5 3801.7 5842.5 5925.3 5927.6 5932.9 5933.7 3951.7 3953.2 3954.8 3955.6 3961.8 4009.9 4014.6 4016.0 4018.1 4018.9 4465.8 4591.8 4657.7 4668.0 4669.0 5638.2 5646.8 5649.0 5651.5 5653.1 1381.5 1388.2 1390.5 1390.8 1391.1 927.3 934.3 936.0 957.8 959.7 4933.4 4947.5 4948.5 4956.6 4958.5 5876.1 5880.1 5883.1 5883.3 5889.4 4939.8 4946.3 4950.4 4950.8 4952.6 3036.2 3063.3 3119.9 3142.6 3152.0 5439.5 5455.8 5580.8 5586.8 5607.1 6032.9 6046.1 6056.3 6068.0 6069.8 5535.2 5586.6 5587.2 5590.2 5595.9 5705.0 5883.1 5925.5 5947.5 5956.4 5727.7 5755.9 5790.2 5794.2 5813.0 5559.1 5588.7 5595.4 5599.6 5608.1 3937.9 4029.8 4075.4 4075.8 4077.5 5882.3 5904.9 5907.9 5908.2 5910.4 5680.7 5682.2 5686.8 5694.1 5695.5 5684.0 5685.4 5687.5 5698.1 5706.8 5420.5 5536.4 5536.4 5574.4 5586.6 5682.9 5684.4 5684.8 5689.6 5696.2 5549.8 5561.7 5564.9 5567.2 5569.5 21:06:54 INFO - PROCESS | 26842 | 21:06:54 INFO - PROCESS | 26842 | [#5] yui.html Cycles:180 Average:11477.21 Median:576.54 stddev:13647.58 (2367.2%) stddev-sans-first:13661.17 21:06:54 INFO - PROCESS | 26842 | Values: 544.3 554.1 630.7 631.6 663.6 9297.9 9528.2 9548.9 9552.5 9560.2 9732.9 10447.8 10619.9 10623.5 10628.3 734.2 750.3 750.8 751.3 752.3 731.8 737.4 739.7 739.7 740.1 776.8 785.2 787.2 787.5 788.0 768.9 769.8 771.0 774.8 779.0 572.5 574.3 575.5 577.5 578.0 9291.5 9427.1 9428.9 9435.6 9436.8 8544.8 8687.3 8904.2 8972.9 9360.1 7761.9 7969.2 8225.5 8249.4 8249.6 2631.6 2636.4 2656.6 2687.0 2687.7 31600.8 32861.8 37022.8 37178.6 40945.6 8223.3 8240.0 8295.1 8433.2 8506.7 14132.2 14164.0 14173.3 14175.1 14186.6 5806.8 5857.5 5918.4 5989.4 6002.6 3225.9 3253.1 3383.7 3395.9 3400.0 2451.3 2480.8 2482.6 2484.2 2484.7 432.4 438.5 450.0 451.0 455.6 360.8 471.4 472.9 474.6 509.0 6755.2 7038.6 7127.0 8015.9 8124.4 380.6 418.1 432.6 438.6 513.7 3165.6 3264.0 3285.6 3306.3 3328.8 47253.3 49464.0 49600.8 49654.3 49677.5 42775.4 43339.6 43445.1 43472.6 43607.0 34696.8 43759.8 43823.3 43971.3 45328.8 7569.2 7590.0 7712.6 7758.3 7901.8 25825.2 27091.7 29755.9 30216.4 30751.1 38281.2 40892.6 41209.4 41647.0 42011.6 9260.2 9294.0 9359.5 9415.8 9589.5 10131.5 10280.4 10396.9 10460.7 10500.4 9930.4 9945.8 9962.7 10198.1 10199.2 9702.8 9847.3 9911.9 9919.0 9931.6 10021.0 10024.1 10046.9 10098.7 10184.2 7673.5 8046.8 8376.5 8421.7 8446.5 7544.7 7776.7 7960.0 8054.1 8132.7 21:06:54 INFO - PROCESS | 26842 | -------- Summary: end -------- 21:06:54 INFO - PROCESS | 26842 | 21:06:55 INFO - TEST-INFO | 26842: exit 0 21:06:55 INFO - TEST-OK | dromaeo_css | took 1117249ms 21:06:55 INFO - TEST-START | kraken 21:06:55 INFO - operating with platform_type : linux_ 21:06:55 INFO - Initialising browser for kraken test... 21:06:55 INFO - TEST-INFO | started process 27024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNaamL7/profile http://localhost:43841/getInfo.html) 21:06:59 INFO - PROCESS | 27024 | __metrics Screen width/height:1600/1200 21:06:59 INFO - PROCESS | 27024 | colorDepth:24 21:06:59 INFO - PROCESS | 27024 | Browser inner width/height: 1024/697 21:06:59 INFO - PROCESS | 27024 | __metrics 21:06:59 INFO - PROCESS | 27024 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:06:59 INFO - PROCESS | 27024 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:07:00 INFO - TEST-INFO | 27024: exit 0 21:07:00 INFO - Browser initialized. 21:07:00 INFO - Running cycle 1/1 for kraken test... 21:07:00 INFO - TEST-INFO | started process 27108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNaamL7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:07:12 INFO - PROCESS | 27108 | RSS: Main: 150310912 21:07:12 INFO - PROCESS | 27108 | 21:07:15 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43841/tests/kraken/driver.html?testName=audio-beat-detection) 21:07:15 INFO - PROCESS | 27108 | RSS: Main: 186322944 21:07:15 INFO - PROCESS | 27108 | 21:07:18 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43841/tests/kraken/driver.html?testName=audio-dft) 21:07:19 INFO - PROCESS | 27108 | RSS: Main: 175443968 21:07:19 INFO - PROCESS | 27108 | 21:07:22 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43841/tests/kraken/driver.html?testName=audio-fft) 21:07:22 INFO - PROCESS | 27108 | RSS: Main: 161988608 21:07:22 INFO - PROCESS | 27108 | 21:07:24 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43841/tests/kraken/driver.html?testName=audio-oscillator) 21:07:25 INFO - PROCESS | 27108 | RSS: Main: 162664448 21:07:25 INFO - PROCESS | 27108 | 21:07:27 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43841/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:07:28 INFO - PROCESS | 27108 | RSS: Main: 165781504 21:07:28 INFO - PROCESS | 27108 | 21:07:31 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43841/tests/kraken/driver.html?testName=imaging-darkroom) 21:07:31 INFO - PROCESS | 27108 | RSS: Main: 164823040 21:07:31 INFO - PROCESS | 27108 | 21:07:35 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43841/tests/kraken/driver.html?testName=imaging-desaturate) 21:07:35 INFO - PROCESS | 27108 | RSS: Main: 166023168 21:07:35 INFO - PROCESS | 27108 | 21:07:38 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43841/tests/kraken/driver.html?testName=json-parse-financial) 21:07:39 INFO - PROCESS | 27108 | RSS: Main: 165814272 21:07:39 INFO - PROCESS | 27108 | 21:07:41 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43841/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:07:41 INFO - PROCESS | 27108 | RSS: Main: 175300608 21:07:41 INFO - PROCESS | 27108 | 21:07:43 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43841/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:07:44 INFO - PROCESS | 27108 | RSS: Main: 174194688 21:07:44 INFO - PROCESS | 27108 | 21:07:46 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43841/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:07:46 INFO - PROCESS | 27108 | RSS: Main: 187547648 21:07:46 INFO - PROCESS | 27108 | 21:07:49 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:07:50 INFO - PROCESS | 27108 | RSS: Main: 189399040 21:07:50 INFO - PROCESS | 27108 | 21:07:52 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:07:53 INFO - PROCESS | 27108 | RSS: Main: 188231680 21:07:53 INFO - PROCESS | 27108 | 21:07:54 INFO - PROCESS | 27108 | Cycle 1(1): loaded http://localhost:43841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43841/tests/kraken/driver.html?testName=ai-astar) 21:07:55 INFO - PROCESS | 27108 | RSS: Main: 246874112 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | __start_tp_report 21:07:55 INFO - PROCESS | 27108 | _x_x_mozilla_page_load 21:07:55 INFO - PROCESS | 27108 | _x_x_mozilla_page_load_details 21:07:55 INFO - PROCESS | 27108 | |i|pagename|runs| 21:07:55 INFO - PROCESS | 27108 | |0;ai-astar;110;114;107;112;115;116;102;112;115;121 21:07:55 INFO - PROCESS | 27108 | |1;audio-beat-detection;160;130;158;169;136;156;155;132;167;133 21:07:55 INFO - PROCESS | 27108 | |2;audio-dft;162;162;161;161;162;161;162;162;162;163 21:07:55 INFO - PROCESS | 27108 | |3;audio-fft;73;73;88;94;78;72;73;123;92;75 21:07:55 INFO - PROCESS | 27108 | |4;audio-oscillator;99;99;142;99;100;99;141;98;99;130 21:07:55 INFO - PROCESS | 27108 | |5;imaging-gaussian-blur;109;109;109;110;109;109;110;110;110;110 21:07:55 INFO - PROCESS | 27108 | |6;imaging-darkroom;147;146;147;147;148;146;146;147;147;147 21:07:55 INFO - PROCESS | 27108 | |7;imaging-desaturate;95;95;95;95;96;95;95;96;95;95 21:07:55 INFO - PROCESS | 27108 | |8;json-parse-financial;71;72;71;71;72;71;70;79;69;68 21:07:55 INFO - PROCESS | 27108 | |9;json-stringify-tinderbox;67;68;67;67;68;69;71;68;67;68 21:07:55 INFO - PROCESS | 27108 | |10;stanford-crypto-aes;85;93;86;85;85;85;85;85;89;85 21:07:55 INFO - PROCESS | 27108 | |11;stanford-crypto-ccm;131;122;128;119;119;129;132;123;130;122 21:07:55 INFO - PROCESS | 27108 | |12;stanford-crypto-pbkdf2;138;151;149;142;151;135;150;147;145;133 21:07:55 INFO - PROCESS | 27108 | |13;stanford-crypto-sha256-iterative;73;71;70;72;70;72;71;72;70;70 21:07:55 INFO - PROCESS | 27108 | __end_tp_report 21:07:55 INFO - PROCESS | 27108 | __start_cc_report 21:07:55 INFO - PROCESS | 27108 | _x_x_mozilla_cycle_collect,990 21:07:55 INFO - PROCESS | 27108 | __end_cc_report 21:07:55 INFO - PROCESS | 27108 | __startTimestamp1451970475199__endTimestamp 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | ------- Summary: start ------- 21:07:55 INFO - PROCESS | 27108 | Number of tests: 14 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.50 stddev:5.23 (4.6%) stddev-sans-first:5.48 21:07:55 INFO - PROCESS | 27108 | Values: 110.0 114.0 107.0 112.0 115.0 116.0 102.0 112.0 115.0 121.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:157.00 stddev:15.21 (9.7%) stddev-sans-first:15.66 21:07:55 INFO - PROCESS | 27108 | Values: 160.0 130.0 158.0 169.0 136.0 156.0 155.0 132.0 167.0 133.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 21:07:55 INFO - PROCESS | 27108 | Values: 162.0 162.0 161.0 161.0 162.0 161.0 162.0 162.0 162.0 163.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#3] audio-fft Cycles:10 Average:84.10 Median:76.50 stddev:16.07 (21.0%) stddev-sans-first:16.54 21:07:55 INFO - PROCESS | 27108 | Values: 73.0 73.0 88.0 94.0 78.0 72.0 73.0 123.0 92.0 75.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:99.00 stddev:18.95 (19.1%) stddev-sans-first:19.62 21:07:55 INFO - PROCESS | 27108 | Values: 99.0 99.0 142.0 99.0 100.0 99.0 141.0 98.0 99.0 130.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:07:55 INFO - PROCESS | 27108 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 21:07:55 INFO - PROCESS | 27108 | Values: 147.0 146.0 147.0 147.0 148.0 146.0 146.0 147.0 147.0 147.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:07:55 INFO - PROCESS | 27108 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:2.95 (4.2%) stddev-sans-first:3.13 21:07:55 INFO - PROCESS | 27108 | Values: 71.0 72.0 71.0 71.0 72.0 71.0 70.0 79.0 69.0 68.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.27 21:07:55 INFO - PROCESS | 27108 | Values: 67.0 68.0 67.0 67.0 68.0 69.0 71.0 68.0 67.0 68.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.00 stddev:2.67 (3.1%) stddev-sans-first:2.79 21:07:55 INFO - PROCESS | 27108 | Values: 85.0 93.0 86.0 85.0 85.0 85.0 85.0 85.0 89.0 85.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:128.50 stddev:5.02 (3.9%) stddev-sans-first:4.91 21:07:55 INFO - PROCESS | 27108 | Values: 131.0 122.0 128.0 119.0 119.0 129.0 132.0 123.0 130.0 122.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:148.00 stddev:6.76 (4.6%) stddev-sans-first:6.80 21:07:55 INFO - PROCESS | 27108 | Values: 138.0 151.0 149.0 142.0 151.0 135.0 150.0 147.0 145.0 133.0 21:07:55 INFO - PROCESS | 27108 | 21:07:55 INFO - PROCESS | 27108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.10 (1.5%) stddev-sans-first:0.93 21:07:55 INFO - PROCESS | 27108 | Values: 73.0 71.0 70.0 72.0 70.0 72.0 71.0 72.0 70.0 70.0 21:07:55 INFO - PROCESS | 27108 | -------- Summary: end -------- 21:07:55 INFO - PROCESS | 27108 | 21:07:56 INFO - TEST-INFO | 27108: exit 0 21:07:56 INFO - TEST-OK | kraken | took 60969ms 21:07:56 INFO - TEST-START | v8_7 21:07:56 INFO - operating with platform_type : linux_ 21:07:56 INFO - Initialising browser for v8_7 test... 21:07:56 INFO - TEST-INFO | started process 27354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMWXIF/profile http://localhost:43841/getInfo.html) 21:08:00 INFO - PROCESS | 27354 | __metrics Screen width/height:1600/1200 21:08:00 INFO - PROCESS | 27354 | colorDepth:24 21:08:00 INFO - PROCESS | 27354 | Browser inner width/height: 1024/697 21:08:00 INFO - PROCESS | 27354 | __metrics 21:08:00 INFO - PROCESS | 27354 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:08:00 INFO - PROCESS | 27354 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:08:01 INFO - TEST-INFO | 27354: exit 0 21:08:01 INFO - Browser initialized. 21:08:01 INFO - Running cycle 1/1 for v8_7 test... 21:08:01 INFO - TEST-INFO | started process 27435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMWXIF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:08:13 INFO - PROCESS | 27435 | RSS: Main: 149917696 21:08:13 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | Cycle 1(1): loaded http://localhost:43841/tests/v8_7/run.html (next: http://localhost:43841/tests/v8_7/run.html) 21:08:35 INFO - PROCESS | 27435 | RSS: Main: 445575168 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | __start_tp_report 21:08:35 INFO - PROCESS | 27435 | _x_x_mozilla_page_load 21:08:35 INFO - PROCESS | 27435 | _x_x_mozilla_page_load_details 21:08:35 INFO - PROCESS | 27435 | |i|pagename|runs| 21:08:35 INFO - PROCESS | 27435 | |0;Richards;167.53224995811695 21:08:35 INFO - PROCESS | 27435 | |1;DeltaBlue;189.42981625307823 21:08:35 INFO - PROCESS | 27435 | |2;Encrypt;278.00945232137894 21:08:35 INFO - PROCESS | 27435 | |3;Decrypt;5263.1578947368425 21:08:35 INFO - PROCESS | 27435 | |4;RayTrace;2016.1290322580646 21:08:35 INFO - PROCESS | 27435 | |5;Earley;809.0614886731391 21:08:35 INFO - PROCESS | 27435 | |6;Boyer;12000 21:08:35 INFO - PROCESS | 27435 | |7;RegExp;26842.105263157893 21:08:35 INFO - PROCESS | 27435 | |8;Splay;614.3470263641938 21:08:35 INFO - PROCESS | 27435 | |9;NavierStokes;4840.579710144928 21:08:35 INFO - PROCESS | 27435 | __end_tp_report 21:08:35 INFO - PROCESS | 27435 | __startTimestamp1451970515529__endTimestamp 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | ------- Summary: start ------- 21:08:35 INFO - PROCESS | 27435 | Number of tests: 10 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 167.5 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#1] DeltaBlue Cycles:1 Average:189.43 Median:189.43 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 189.4 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 278.0 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 5263.2 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#4] RayTrace Cycles:1 Average:2016.13 Median:2016.13 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 2016.1 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#5] Earley Cycles:1 Average:809.06 Median:809.06 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 809.1 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 12000.0 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#7] RegExp Cycles:1 Average:26842.11 Median:26842.11 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 26842.1 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#8] Splay Cycles:1 Average:614.35 Median:614.35 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 614.3 21:08:35 INFO - PROCESS | 27435 | 21:08:35 INFO - PROCESS | 27435 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 21:08:35 INFO - PROCESS | 27435 | Values: 4840.6 21:08:35 INFO - PROCESS | 27435 | -------- Summary: end -------- 21:08:35 INFO - PROCESS | 27435 | 21:08:36 INFO - TEST-INFO | 27435: exit 0 21:08:36 INFO - TEST-OK | v8_7 | took 40281ms 21:08:36 INFO - SUITE-END | took 1218s 21:08:36 INFO - Completed test suite (00:20:18) 21:08:36 INFO - Working with test: dromaeo_css 21:08:36 INFO - Generating results file: dromaeo_css 21:08:36 INFO - Working with test: kraken 21:08:36 INFO - Generating results file: kraken 21:08:36 INFO - javascript benchmark 21:08:36 INFO - Working with test: v8_7 21:08:36 INFO - Generating results file: v8_7 21:08:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:08:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 21:08:36 INFO - process_Request line: dromaeo_css 5932.79 graph.html#tests=[[72,203,35]] 21:08:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:08:36 INFO - process_Request line: kraken 1536.40 graph.html#tests=[[232,203,35]] 21:08:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:08:36 INFO - process_Request line: v8_7 19649.88 graph.html#tests=[[230,203,35]] 21:08:36 INFO - RETURN: dromaeo_css: 5932.79 21:08:36 INFO - RETURN: kraken: 1536.40 21:08:36 INFO - RETURN: v8_7: 19649.88 21:08:36 INFO - javascript benchmark 21:08:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2595.9351016224596, 2688.6101515280284, 2691.031228757648, 2703.7972152088587, 2723.591461280808, 4404.29531274996, 4536.795844187011, 4599.379083823683, 4601.562851529104, 4616.938104236024, 4542.500324964251, 4552.817887284505, 4608.516105808883, 4621.71888863412, 4628.236341003731, 4188.832446702128, 4208.97895510522, 4277.144571085788, 4336.392904993303, 4348.130373925212, 4052.3111071117833, 4298.16185843759, 4345.109252603224, 4360.25875601147, 4382.211201983641, 4192.916141677149, 4199.286121359376, 4259.297215959363, 4293.119910418357, 4330.155619654169, 4240.830366785325, 4247.256730072256, 4249.830006799724, 4287.099709061101, 4288.0351920817875, 4033.193361327717, 4227.154569086164, 4248.4052232687445, 4248.957510424887, 4283.721558098714, 4433.312836510314, 4441.533638967894, 4451.821927122911, 4563.840265590688, 4594.448666160049, 4914.0908931847725, 4953.801847926079, 4955.405351357824, 4958.454569997298, 4991.850244492671, 4729.314249433847, 4964.230544265644, 4970.726610036447, 4973.403191617029, 4975.651704380694, 4450.221211288012, 4464.15181115587, 4515.864524064284, 4548.681592288508, 4606.355110284563, 5005.524475174852, 5008.799648014112, 5010.749462526859, 5014.674046186986, 5061.240813877874, 4635.420572428447, 4826.638002149783, 4834.734089625034, 4837.05677392912, 4838.371011768448, 4795.232762758012, 4814.398200224972, 4893.119238537026, 4991.376077990251, 5002.299678045077, 4870.318155458239, 4877.975610121997, 4878.390201224847, 4896.902061958812, 4927.95072049282, 4859.125357435695, 4859.902801943941, 4867.878303042452, 4871.756412179448, 4920.655554111249, 4033.616806403387, 4115.300398932189, 4132.938005929914, 4133.607307305801, 4166.208420400114, 3652.251288485854, 3656.140806910374, 3672.485851980725, 3695.870644527429, 3699.741018128705, 4241.088166044316, 4241.63946064588, 4241.681873859473, 4272.893177670521, 4283.785810709514, 4656.254999200111, 4823.807047718122, 4824.734639594856, 4843.709377437365, 4931.309616653672, 4227.492700875853, 4236.745795252295, 4245.787710614457, 4268.701190916669, 4274.5939135782055, 4415.823367065282, 4429.269170586817, 4430.269005614037, 4435.3125265583885, 4470.195364834361, 4474.284114541658, 4578.702384345007, 4584.954150458453, 4616.26139817641, 4741.857744267678, 4948.38145231846, 4950.257461380822, 4976.154053810933, 4976.427710813158, 4997.9500204997485, 4699.600533954652, 4699.694519856198, 4702.835400761094, 4737.928931066106, 4743.549362810528, 4609.400777898852, 4715.151272770797, 4717.834875779331, 4793.760311984317, 4894.045661096052, 4908.558229759339, 4908.680935739309, 4911.410630724193, 4928.433230178575, 4944.975275123601, 4762.380890484214, 4763.356946812136, 4765.285207218945, 4768.356271903249, 4805.087033463631, 4546.068056048568, 4651.558101980307, 4653.952860606337, 4769.809207631656, 4809.831655892027, 4623.491415944311, 4689.742064186366, 4694.600958918393, 4705.317728929354, 4729.337892694956, 4821.156297647968, 4821.614270858253, 4824.252240902666, 4848.5636292733825, 4858.659893807399, 4570.085982803386, 4638.6752927294765, 4674.252119660974, 4729.8108075677965, 4769.95230047709], "unit": "score", "name": "dojo.html", "value": 4507.768504798209}, {"lowerIsBetter": false, "replicates": [499.02191704259644, 506.3417557175671, 518.5877227604054, 529.2352550564435, 562.4600383631711, 24486.87756561217, 24883.0, 24900.377490562743, 24927.626085608732, 31752.523712144277, 34583.4812477813, 35062.824685876534, 35081.649183508154, 35203.82398088012, 35254.64745352546, 7653.808654783619, 7828.099768526636, 7833.216678332178, 7835.6473958671995, 7841.0, 6983.511154219207, 7163.498555101145, 7636.770896873103, 9955.651552195675, 10274.178065754759, 9735.805283894319, 9814.067663571985, 9825.4104753715, 9825.90174098257, 9828.852567211497, 7043.68303426347, 9830.164436022947, 9922.156616687591, 9947.055029772197, 9971.351862128939, 6711.832204194885, 9744.171745401649, 9954.552045157985, 9961.950190249003, 9962.0, 32687.836560817283, 32853.17867053319, 33067.83466082654, 33070.669293307, 33073.0, 2301.2635956493928, 2384.9046038158453, 2440.7681270279295, 2485.3538080099124, 2580.600006998918, 22618.0, 23028.0, 23051.654225186634, 23176.420589485228, 27193.0, 3012.9096127116222, 3081.445339838828, 3100.922476938072, 3138.4821504451966, 3224.1456014156265, 223896.0, 224327.0, 224741.0, 225914.0, 226137.0, 47735.5226447738, 49242.75378623084, 50539.73650658763, 50883.49116508788, 51349.74325128425, 54552.0, 55486.16770748442, 55652.0, 55691.72154139284, 55735.163972540446, 9794.853077203848, 9867.210623150131, 9905.950470247602, 9928.0, 9945.751356216153, 7682.423818213656, 7763.301302882767, 7786.065672119382, 7787.260210280015, 7789.143194248628, 14310.356033978496, 14371.0, 14410.639734006734, 14440.0, 14562.271886405637, 6848.417884479775, 7071.720605634006, 7143.392811610967, 7217.7473788417155, 7255.419566434673, 758.9051368578928, 776.4681193382438, 935.209747763139, 973.5035132082688, 991.7371896447447, 25769.742302576735, 25949.61075583868, 26012.349691257492, 26046.0, 26184.8690756545, 894.4633220067907, 902.873597696323, 903.9683611073581, 993.9712397668378, 1009.5255230041869, 13113.409896554678, 13412.195268283738, 13680.0, 14344.354504047344, 14366.712665746627, 263417.0, 265806.0, 267856.0, 267883.0, 269373.0, 37080.0, 37344.43983340252, 37393.06517337088, 37421.43867841984, 37447.25105497875, 1114.5820317380983, 1129.2885482146196, 1129.76274982253, 1137.0392018744149, 1139.0773473486668, 20519.0, 21245.46886327854, 21250.78749212488, 21464.356069317946, 23394.415139621644, 35345.823270883484, 36224.0, 40277.39583906302, 41215.0, 41256.174876501704, 164450.0, 165630.0, 166857.0, 166978.0, 167069.0, 23610.645840312067, 24189.879050604635, 24198.0, 25589.232323030337, 26057.609135863357, 26203.475930481665, 26366.0, 28781.85609071941, 31287.217819554695, 34989.650103498636, 29556.0, 29746.0, 30356.392872142875, 30699.539506907862, 30715.0, 30163.245918852204, 30376.392472150874, 30521.847390762905, 30618.540721888745, 30684.0, 29278.26804329909, 30700.0, 30731.2317192072, 30750.38499229958, 33304.666953330154, 27697.0, 28082.438351233268, 29227.7077229225, 29662.258443539085, 29751.851240743657, 20690.793092068885, 20973.370798876058, 21010.159593616696, 21807.23674671379, 21875.0], "unit": "score", "name": "ext.html", "value": 15322.440620750947}, {"lowerIsBetter": false, "replicates": [325.65317936397724, 327.2505961348512, 328.4941190566528, 328.6926723513514, 335.4180496837987, 12332.4450399732, 12781.424835882384, 14594.70810583789, 15074.623134421645, 16027.118508482028, 12547.0, 12634.936825315883, 12885.355732213398, 12891.162074465154, 13019.283939383331, 4865.318855360252, 4997.850064498062, 5119.12974794284, 5135.691858488484, 5136.101182293102, 3489.755717099804, 3608.7293452991, 4977.6266779991465, 5011.799528018875, 5201.271821944912, 5152.304438900756, 5161.7161056141895, 5165.354330708661, 5180.870478238036, 5187.584993200554, 5028.7737051832755, 5143.485651434864, 5682.51698605619, 5758.798442054508, 5773.797917072882, 5194.92207616886, 5209.739513024334, 5210.140326846066, 5211.140161873286, 5214.582833373321, 11071.339299105119, 11719.121065920004, 11862.644120676394, 11871.703207419883, 11874.0500759939, 1698.498942811861, 1751.5708651380367, 1830.4508647405726, 1845.769278840145, 1881.868269221155, 9002.549872506348, 9016.77458063547, 9091.136342047495, 10491.213159013105, 12509.0, 1563.7341651919087, 1629.08771088191, 1635.2314412226235, 1694.9406770763087, 1709.905955172465, 54086.18870716942, 55432.16851747227, 55495.44504554943, 56253.156202656995, 57441.13838292429, 9109.180173784258, 9479.810403792024, 9749.65876194344, 9750.317477776629, 9808.411495310162, 12494.75010499785, 12520.373981300898, 12521.56174533887, 12526.060545458944, 12535.122541422195, 5685.772569097273, 5862.062070068769, 5894.145348924382, 6057.3336932937345, 6092.695365231721, 5565.1095824667855, 5575.107982722745, 5609.551235901118, 5645.350784659735, 5670.0, 4093.467849179647, 4164.083901541656, 4212.810423530948, 4232.576742325804, 4252.170826688766, 1586.7461206206951, 1623.131624580867, 1676.2121802752931, 1694.7203711387729, 1700.1329322045847, 765.3915137465729, 805.2390490985962, 810.805406702399, 837.8324335132997, 877.8946526416743, 14741.705165896621, 15372.0, 15547.844521554865, 15700.371985120695, 16141.273642686107, 712.5795780489433, 713.9901178183501, 780.0678189563417, 808.6805711743946, 810.7689308547153, 8110.472819266729, 8123.878141827878, 8176.264136227649, 8392.076871544125, 8479.321654267644, 121474.0, 122007.38996304962, 122062.38968805276, 122107.38946305211, 122400.0, 68115.3188468109, 69397.0, 72168.27831721616, 72534.55990800711, 73459.0, 1015.0610685116238, 1031.4275577054807, 1036.7874585709912, 1040.9687709368732, 1042.0413219837767, 12671.669474705022, 13087.345632718136, 13129.803052954405, 13147.211167329991, 13245.867541324464, 29839.254018649706, 29918.551221732127, 29928.850355748084, 30441.391172176875, 30888.227794305323, 43516.56483435125, 44862.3270650947, 45069.0, 47151.29273060838, 47358.05283894372, 8532.658693652184, 8650.0, 8758.03661597211, 9054.049324821062, 9064.592093355683, 15513.22433878279, 15973.201339932724, 15994.120323382325, 16001.359945602046, 16229.188540573161, 12415.689607759878, 12416.75166496683, 12587.622371328875, 13791.724165516835, 13956.581302560939, 12496.500139994298, 13030.153040052366, 13373.866261337262, 13384.397702103623, 13501.527446539323, 12464.937675311565, 12945.223286602833, 12980.675483112998, 12986.675333116369, 13238.602841914759, 7990.92009079925, 8670.696525621574, 9084.727458176265, 9095.727128186165, 9114.954425227832, 9271.582778774837, 9369.812603748023, 11403.0, 12969.935150324189, 13378.9331053348], "unit": "score", "name": "jquery.html", "value": 7561.354607613046}, {"lowerIsBetter": false, "replicates": [1210.8365370674956, 1290.1420555330706, 1362.93185340733, 1433.6702558411564, 1663.3679201903283, 5829.32962709288, 6263.31103578606, 6332.208473940757, 6337.207849018872, 6371.235451745792, 6402.519811014169, 6591.571547849387, 6600.735970561183, 6602.844502212106, 6609.867802643944, 1989.8209161175455, 2026.6048120616485, 2028.3002364184406, 2028.6145632329883, 2029.4926268432891, 2027.290448343083, 2042.765082015565, 2051.9897400512978, 2071.513194399315, 2080.3966849613594, 1988.8607797454183, 1995.9101840417215, 2023.109831674066, 2023.2008356699096, 2024.1397406102421, 2016.5563576013253, 2027.6147531968952, 2030.6446371885008, 2037.847161462896, 2041.387583724884, 1987.0859404673722, 2030.157484643871, 2050.138941644498, 2054.291269512031, 2055.7841426650134, 6567.704453299613, 6649.135612370409, 6649.135612370409, 6650.434713049397, 6671.566348187353, 3850.537935447764, 3921.274564205631, 3921.7058720595783, 3927.19492504036, 3929.292727309083, 2569.2677586887835, 2593.07945679283, 2632.921012369632, 2664.640273563083, 2689.099151784155, 805.907320658126, 809.5102463009853, 821.6220538552274, 833.2584000239731, 833.4874052457756, 9240.722778316662, 9270.49012304323, 9274.350795444321, 9278.72163835086, 9281.257499400099, 3729.1236559408517, 3742.326381251401, 3750.1749615084636, 3800.7339486235696, 3801.7148713846573, 7901.604919754104, 7903.525788452711, 7918.28735413804, 7922.445428819928, 7923.088844782924, 3851.9614803852164, 3854.0, 3859.073822282688, 3863.343231650626, 3872.9806350968065, 3046.466868298083, 3121.6254049514205, 3538.5046093546925, 3549.4143466328283, 3554.129238336624, 3151.023182813289, 3155.1323386069016, 3161.0832858470785, 3170.4927211646027, 3208.5668434761474, 1011.0445628880784, 1030.0677886512717, 1032.4734385463319, 1037.190991027, 1037.3205550364373, 924.3298608508777, 933.5892207428709, 949.7103383468109, 949.7483166960761, 951.2247518272586, 6048.818535443944, 6187.597806142587, 6197.318294987548, 6197.96901015492, 6207.068939658997, 979.588572799426, 1053.942033188182, 1068.2415485005733, 1075.693427373195, 1076.499427766077, 4646.279826626878, 4657.976710116428, 4713.882152946204, 4716.504766999485, 4726.243800991825, 8155.184481551916, 8209.343252539782, 8313.667453301921, 8491.405601607952, 8502.574871256413, 8349.707760228484, 8374.036985746596, 8386.87419688705, 8405.075441701409, 8453.661853525913, 5916.55625828056, 5971.104334349882, 6057.666828324484, 6089.512838972872, 6095.146679464879, 5981.700914954322, 6002.219711437485, 6002.789902353396, 6010.188624535632, 6013.819585412444, 7575.962120189364, 7726.304632583095, 7747.334323120556, 7769.456138070281, 7777.144514103557, 7725.266099720518, 7898.407619428681, 7919.0, 7931.0, 8051.0, 4819.855404337875, 4932.062908047459, 5548.528375088163, 5620.522255608319, 5622.690752008679, 6012.609180403435, 6124.265088189446, 6150.7539698411565, 6155.2921414037955, 6158.476529495043, 5761.942380576141, 5826.300843898759, 5833.883322333614, 5849.327327357409, 5978.252718410199, 5789.45000224978, 5823.505002074871, 5884.0, 5886.58793884424, 5891.970540147443, 5660.066089095418, 5702.515286200553, 5705.258316418839, 5718.085106383125, 5729.0, 5523.502884740393, 5525.4474552544425, 5547.472990065938, 5552.50027497511, 5574.219609254626, 5622.578306626938, 5637.126245431965, 5646.943530564642, 5656.43435656431, 5662.235598194191], "unit": "score", "name": "mootools.html", "value": 3844.5036151346126}, {"lowerIsBetter": false, "replicates": [285.86992918222205, 290.33368419477296, 293.6842893889069, 296.7166356129896, 298.4240415997125, 5323.307969963899, 5381.165919282513, 5409.810656627019, 5457.017736807373, 5504.889902201953, 5318.282031925699, 5343.171808369709, 5362.168863826113, 5368.677879327233, 5401.891962160755, 4147.212029714345, 4147.626713595776, 4149.481314835645, 4152.1280531088505, 4153.356229784388, 3827.5789663137034, 3898.9025274368228, 4004.0790618157694, 4079.0822065035427, 4079.938800917989, 4054.776987265699, 4067.0, 4080.6123418275215, 4084.65280451162, 4086.3870419437176, 3807.257584770971, 3883.37865941448, 4071.1654110907193, 4081.10215752534, 4089.8159582818694, 3411.692947634725, 3482.9303413931834, 3488.773229740059, 3490.406630872758, 3491.965080349215, 5145.588352931756, 5160.741962901878, 5161.27742116104, 5173.9741301293625, 5190.11767999441, 4642.187617166982, 4646.674732768707, 4653.139169253699, 4653.627709783209, 4654.325122857201, 5455.372632147314, 5604.943950560483, 5611.446791709763, 5621.072523033695, 5632.408597097327, 3793.070697679086, 3796.5823759386444, 3798.6391292827416, 3800.5439347278225, 3801.657850793414, 5842.532597392198, 5925.31858836235, 5927.614705044201, 5932.9406705932815, 5933.703314834284, 3951.68386529077, 3953.2488827122756, 3954.8220330085214, 3955.584663610337, 3961.8217180226957, 4009.919801603952, 4014.6186112319283, 4016.036151323661, 4018.1361007383553, 4018.8794336169963, 4465.754383508938, 4591.8392856249875, 4657.673962822638, 4668.0, 4668.976655116703, 5638.238837756932, 5646.802361917313, 5649.0, 5651.519620832193, 5653.095504719226, 1381.5026590427437, 1388.2434073430004, 1390.4577214886203, 1390.8122403475604, 1391.1166409330149, 927.2952556057445, 934.303943562037, 936.0452338614575, 957.8467445208734, 959.6881013670585, 4933.432655244621, 4947.505249475023, 4948.529889660476, 4956.628252881048, 4958.479359667255, 5876.118582212703, 5880.088586269135, 5883.0881213411985, 5883.294004719375, 5889.381614930457, 4939.802407903644, 4946.332245146859, 4950.356453661001, 4950.777215025332, 4952.62855285855, 3036.1802313375265, 3063.341381602966, 3119.9376012479624, 3142.591463109781, 3151.9684803152136, 5439.456054394529, 5455.809046683347, 5580.832575022756, 5586.804461843816, 5607.102863541813, 6032.939670603238, 6046.093086037042, 6056.273247210363, 6068.0, 6069.757209711651, 5535.169724541351, 5586.636868603528, 5587.189857470644, 5590.161475778666, 5595.860103497445, 5705.0, 5883.058710606282, 5925.496332811759, 5947.524198064058, 5956.434138756811, 5727.68497732612, 5755.856103597276, 5790.247267855152, 5794.2177805997335, 5812.953668339739, 5559.11054231321, 5588.6646801192055, 5595.440455954372, 5599.580031497735, 5608.130739735348, 3937.8818635440985, 4029.798510074426, 4075.4090656855183, 4075.8369665214245, 4077.5310839253866, 5882.323532793784, 5904.852378690567, 5907.940920590739, 5908.202392676933, 5910.408959104056, 5680.7443665036, 5682.176084467812, 5686.77252909879, 5694.1458781183155, 5695.544356451557, 5684.0, 5685.403032681675, 5687.544996400361, 5698.145278208136, 5706.771729130788, 5420.539254163283, 5536.390996990408, 5536.446355364431, 5574.414686457863, 5586.636868603528, 5682.886342273048, 5684.431556844283, 5684.77260909559, 5689.573282003784, 5696.174054762119, 5549.805756798492, 5561.748606563491, 5564.91652625219, 5567.24842146305, 5569.498745112959], "unit": "score", "name": "prototype.html", "value": 4201.888879569402}, {"lowerIsBetter": false, "replicates": [544.2706772924283, 554.0995881692251, 630.7445484578748, 631.5894668465497, 663.6250518457068, 9297.907020929797, 9528.190103841182, 9548.904510954888, 9552.474613896251, 9560.235181185497, 9732.854007189897, 10447.791044179112, 10619.946900265508, 10623.52194151263, 10628.256022078438, 734.2107234722681, 750.3322043381395, 750.8010377250006, 751.2712668711341, 752.2665401233808, 731.7585196885042, 737.4137560639305, 739.6634531288278, 739.6634531288278, 740.097081560498, 776.7863837444692, 785.1873311122989, 787.1695361393756, 787.4684587903171, 787.9803004924865, 768.8731359325704, 769.796004058922, 770.96916123355, 774.7830607429929, 779.0456690554055, 572.481903876992, 574.2678085441054, 575.5338176077349, 577.5466258986676, 578.0, 9291.48896810675, 9427.104425079606, 9428.905710942872, 9435.575399107056, 9436.764080897963, 8544.829103417958, 8687.3050155988, 8904.154105359981, 8972.910270897339, 9360.063993600654, 7761.883571746428, 7969.203079692043, 8225.506469611842, 8249.422540422172, 8249.587520624005, 2631.6184153297854, 2636.4068084680985, 2656.628072069912, 2687.0192379781433, 2687.705220715188, 31600.841995789873, 32861.83569082139, 37022.81488592567, 37178.628213717784, 40945.59054409448, 8223.342132629376, 8240.0, 8295.092128810407, 8433.19884610961, 8506.74479765608, 14132.222727749866, 14164.0, 14173.291335433187, 14175.078619889675, 14186.645333866529, 5806.767729290866, 5857.502112320415, 5918.408159184047, 5989.431004054608, 6002.639841609517, 3225.854836532362, 3253.089135042192, 3383.7293016558615, 3395.932081358359, 3400.0479865637662, 2451.2768733223743, 2480.838745481538, 2482.5779617465073, 2484.1926373928186, 2484.67699199103, 432.41623807859764, 438.53077207387787, 449.9685022048491, 450.96843220974876, 455.640044364948, 360.80696827197846, 471.3683663890335, 472.94505374149264, 474.6178337651054, 509.0480800902262, 6755.189377274758, 7038.577685338896, 7126.964365178141, 8015.919840801634, 8124.431289809657, 380.55094987913975, 418.101082672251, 432.63658526837605, 438.5592479558024, 513.6609837507302, 3165.572647692532, 3264.0, 3285.6221534523356, 3306.272620023591, 3328.783629064103, 47253.29120063202, 49464.0, 49600.751996239786, 49654.25518617224, 49677.50322496729, 42775.35836962448, 43339.56660433355, 43445.131097377875, 43472.565274347486, 43607.0, 34696.82651586776, 43759.78120109379, 43823.34264986028, 43971.34042989358, 45328.77335613301, 7569.205233450409, 7590.0, 7712.5758083305955, 7758.3017528422715, 7901.802454938443, 25825.225243242734, 27091.72908270892, 29755.851220743756, 30216.395672086874, 30751.077467676005, 38281.234375312895, 40892.59107408888, 41209.38185927273, 41647.0, 42011.579884200764, 9260.212881905114, 9293.953530232306, 9359.532023398939, 9415.81168376615, 9589.472579008221, 10131.544080516542, 10280.434576098087, 10396.896031039592, 10460.738481538023, 10500.443708807334, 9930.354526955725, 9945.751356216153, 9962.651307204213, 10198.133158681298, 10199.184065274612, 9702.805943881223, 9847.310688251753, 9911.900880991097, 9919.0, 9931.602735890483, 10021.048000439947, 10024.097831195228, 10046.899531004596, 10098.697039088838, 10184.236182286506, 7673.462857599914, 8046.758597242092, 8376.49741015541, 8421.70524031656, 8446.493210407396, 7544.698212071456, 7776.727814526691, 7960.0, 8054.073781515201, 8132.715354962548], "unit": "score", "name": "yui.html", "value": 5168.193029484935}], "name": "dromaeo_css", "value": 5932.794812514647}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 107.0, 112.0, 115.0, 116.0, 102.0, 112.0, 115.0, 121.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [160.0, 130.0, 158.0, 169.0, 136.0, 156.0, 155.0, 132.0, 167.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 88.0, 94.0, 78.0, 72.0, 73.0, 123.0, 92.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [99.0, 99.0, 142.0, 99.0, 100.0, 99.0, 141.0, 98.0, 99.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 71.0, 72.0, 71.0, 70.0, 79.0, 69.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 69.0, 71.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 89.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [131.0, 122.0, 128.0, 119.0, 119.0, 129.0, 132.0, 123.0, 130.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [138.0, 151.0, 149.0, 142.0, 151.0, 135.0, 150.0, 147.0, 145.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 70.0, 72.0, 70.0, 72.0, 71.0, 72.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1536.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [189.42981625307823], "unit": "score", "name": "DeltaBlue", "value": 349.0369219999999}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [2016.1290322580646], "unit": "score", "name": "RayTrace", "value": 367.03454399999987}, {"lowerIsBetter": false, "replicates": [809.0614886731391], "unit": "score", "name": "Earley", "value": 823.7482679999999}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [26842.105263157893], "unit": "score", "name": "RegExp", "value": 33.93865686274513}, {"lowerIsBetter": false, "replicates": [614.3470263641938], "unit": "score", "name": "Splay", "value": 132.64652794411182}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19649.883897404998}]} 21:08:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19649.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1536.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "5932.79"}}} 21:08:36 INFO - Return code: 0 21:08:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:08:36 INFO - # TBPL SUCCESS # 21:08:36 INFO - Running post-action listener: _resource_record_post_action 21:08:36 INFO - Running post-run listener: _resource_record_post_run 21:08:37 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 544481280; Read time: 0; Write time: 433792 21:08:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227901440; Read time: 0; Write time: 242280 21:08:37 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 315715584; Read time: 0; Write time: 191472 21:08:37 INFO - Running post-run listener: _upload_blobber_files 21:08:37 INFO - Blob upload gear active. 21:08:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:08:37 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 21:08:37 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', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:08:37 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 B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:08:38 INFO - (blobuploader) - INFO - Open directory for files ... 21:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:39 INFO - (blobuploader) - INFO - Done attempting. 21:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:39 INFO - (blobuploader) - INFO - Done attempting. 21:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 21:08:39 INFO - Return code: 0 21:08:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:08:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/8a4ec0d2016489d7c3abe13527cf7495b8497900c02cf0fde915aabb222fe902a6ee2f12840acebd9a491dbed622f174071ea8751512d041e0381880e92197a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/e971368938940a155ad74894761fb26f1731ad21102fb364c70bf93aadaeb547563e3259bfc00e219145f52cbb501199ec57e0d6d481a2b9aa3349be51ad27e5"} 21:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:08:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:08:39 INFO - Contents: 21:08:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/8a4ec0d2016489d7c3abe13527cf7495b8497900c02cf0fde915aabb222fe902a6ee2f12840acebd9a491dbed622f174071ea8751512d041e0381880e92197a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/e971368938940a155ad74894761fb26f1731ad21102fb364c70bf93aadaeb547563e3259bfc00e219145f52cbb501199ec57e0d6d481a2b9aa3349be51ad27e5"} 21:08:39 INFO - Copying logs to upload dir... 21:08:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.366003 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-04 21:08:38.886243) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 21:08:38.889539) ========= 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=232498196343f89f466a4a9a000001c8-1451969246.958566-865673897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/8a4ec0d2016489d7c3abe13527cf7495b8497900c02cf0fde915aabb222fe902a6ee2f12840acebd9a491dbed622f174071ea8751512d041e0381880e92197a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/e971368938940a155ad74894761fb26f1731ad21102fb364c70bf93aadaeb547563e3259bfc00e219145f52cbb501199ec57e0d6d481a2b9aa3349be51ad27e5"} build_url:https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/K2WefWCUQriN_WmXYcVBlA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/8a4ec0d2016489d7c3abe13527cf7495b8497900c02cf0fde915aabb222fe902a6ee2f12840acebd9a491dbed622f174071ea8751512d041e0381880e92197a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/e971368938940a155ad74894761fb26f1731ad21102fb364c70bf93aadaeb547563e3259bfc00e219145f52cbb501199ec57e0d6d481a2b9aa3349be51ad27e5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 21:08:38.915500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:08:38.916007) ========= 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=232498196343f89f466a4a9a000001c8-1451969246.958566-865673897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:08:38.997431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 21:08:38.997787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 21:08:38.998156) ========= ========= Total master_lag: 0.22 =========