builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1452738888.08 results: success (0) buildid: 20160113171930 builduid: c6600de6fc1f4e0a8632b51eb1a696d2 revision: c970bca8297d3a6e348c539b8cb9aa68e19087be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.083248) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.083719) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.084020) ========= 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=4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.106447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.106722) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.119915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.120201) ========= 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=4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.168693) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.168999) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.169384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.169899) ========= 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=4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 18:34:48-- 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% 24.3M=0s 2016-01-13 18:34:48 (24.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.346051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.346366) ========= 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=4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021901 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.395681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.396051) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c970bca8297d3a6e348c539b8cb9aa68e19087be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c970bca8297d3a6e348c539b8cb9aa68e19087be --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=4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 18:34:48,507 truncating revision to first 12 chars 2016-01-13 18:34:48,507 Setting DEBUG logging. 2016-01-13 18:34:48,507 attempt 1/10 2016-01-13 18:34:48,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c970bca8297d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 18:34:48,756 unpacking tar archive at: mozilla-central-c970bca8297d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548037 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.956617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.956891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.966846) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.967135) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 18:34:48.967515) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-13 18:34:48.967794) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:34:49 INFO - MultiFileLogger online at 20160113 18:34:49 in /builds/slave/test 18:34:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:34:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:34:49 INFO - {'append_to_log': False, 18:34:49 INFO - 'base_work_dir': '/builds/slave/test', 18:34:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:34:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:34:49 INFO - 'branch': 'Firefox-Non-PGO', 18:34:49 INFO - 'buildbot_json_path': 'buildprops.json', 18:34:49 INFO - 'config_files': ('talos/linux_config.py',), 18:34:49 INFO - 'default_actions': ('clobber', 18:34:49 INFO - 'read-buildbot-config', 18:34:49 INFO - 'download-and-extract', 18:34:49 INFO - 'populate-webroot', 18:34:49 INFO - 'create-virtualenv', 18:34:49 INFO - 'install', 18:34:49 INFO - 'run-tests'), 18:34:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:34:49 INFO - 'download_minidump_stackwalk': True, 18:34:49 INFO - 'download_symbols': 'ondemand', 18:34:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:34:49 INFO - 'tooltool.py': '/tools/tooltool.py', 18:34:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:34:49 INFO - '/tools/misc-python/virtualenv.py')}, 18:34:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:34:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:34:49 INFO - 'installer_path': 'installer.exe', 18:34:49 INFO - 'log_level': 'info', 18:34:49 INFO - 'log_name': 'talos', 18:34:49 INFO - 'log_to_console': True, 18:34:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:34:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:34:49 INFO - 'opt_config_files': (), 18:34:49 INFO - 'pip_index': False, 18:34:49 INFO - 'sps_profile': False, 18:34:49 INFO - 'sps_profile_interval': 0, 18:34:49 INFO - 'suite': 'dromaeojs-e10s', 18:34:49 INFO - 'system_bits': '32', 18:34:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:34:49 INFO - 'title': 'talos-linux64-ix-024', 18:34:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:34:49 INFO - 'use_talos_json': True, 18:34:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:34:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:34:49 INFO - 'work_dir': 'build'} 18:34:49 INFO - ##### 18:34:49 INFO - ##### Running clobber step. 18:34:49 INFO - ##### 18:34:49 INFO - Running pre-action listener: _resource_record_pre_action 18:34:49 INFO - Running main action method: clobber 18:34:49 INFO - rmtree: /builds/slave/test/build 18:34:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:34:49 INFO - Running post-action listener: _resource_record_post_action 18:34:49 INFO - ##### 18:34:49 INFO - ##### Running read-buildbot-config step. 18:34:49 INFO - ##### 18:34:49 INFO - Running pre-action listener: _resource_record_pre_action 18:34:49 INFO - Running main action method: read_buildbot_config 18:34:49 INFO - Using buildbot properties: 18:34:49 INFO - { 18:34:49 INFO - "project": "", 18:34:49 INFO - "product": "firefox", 18:34:49 INFO - "script_repo_revision": "production", 18:34:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:34:49 INFO - "repository": "", 18:34:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:34:49 INFO - "buildid": "20160113171930", 18:34:49 INFO - "pgo_build": "False", 18:34:49 INFO - "basedir": "/builds/slave/test", 18:34:49 INFO - "buildnumber": 207, 18:34:49 INFO - "slavename": "talos-linux64-ix-024", 18:34:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:34:49 INFO - "platform": "ubuntu64_hw", 18:34:49 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:34:49 INFO - "branch": "mozilla-central", 18:34:49 INFO - "repo_path": "mozilla-central", 18:34:49 INFO - "revision": "c970bca8297d3a6e348c539b8cb9aa68e19087be", 18:34:49 INFO - "stage_platform": "linux64", 18:34:49 INFO - "builduid": "c6600de6fc1f4e0a8632b51eb1a696d2", 18:34:49 INFO - "slavebuilddir": "test" 18:34:49 INFO - } 18:34:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:34:49 INFO - Running post-action listener: _resource_record_post_action 18:34:49 INFO - ##### 18:34:49 INFO - ##### Running download-and-extract step. 18:34:49 INFO - ##### 18:34:49 INFO - Running pre-action listener: _resource_record_pre_action 18:34:49 INFO - Running main action method: download_and_extract 18:34:49 INFO - mkdir: /builds/slave/test/build/tests 18:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:49 INFO - https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:34:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/test_packages.json 18:34:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/test_packages.json 18:34:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:34:56 INFO - Downloaded 1448 bytes. 18:34:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:34:56 INFO - Using the following test package requirements: 18:34:56 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:34:56 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:34:56 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:34:56 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:56 INFO - u'jsshell-linux-x86_64.zip'], 18:34:56 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:34:56 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:34:56 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:34:56 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:34:56 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:34:56 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:34:56 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:34:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:34:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:56 INFO - https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:34:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:34:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:34:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:35:01 INFO - Downloaded 22760516 bytes. 18:35:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:35:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:35:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:35:02 INFO - Return code: 0 18:35:02 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:02 INFO - https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:35:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:35:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:35:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:35:06 INFO - Downloaded 22760516 bytes. 18:35:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:35:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:35:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:35:07 INFO - Return code: 0 18:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:07 INFO - https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:35:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:35:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:35:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:35:09 INFO - Downloaded 11132279 bytes. 18:35:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:35:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:35:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:35:10 INFO - Return code: 0 18:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:10 INFO - https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:35:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:35:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:35:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:35:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:35:13 INFO - Downloaded 53903624 bytes. 18:35:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:35:13 INFO - mkdir: /builds/slave/test/properties 18:35:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:35:13 INFO - Writing to file /builds/slave/test/properties/build_url 18:35:13 INFO - Contents: 18:35:13 INFO - build_url:https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:35:13 INFO - Running post-action listener: _resource_record_post_action 18:35:13 INFO - Running post-action listener: set_extra_try_arguments 18:35:13 INFO - ##### 18:35:13 INFO - ##### Running populate-webroot step. 18:35:13 INFO - ##### 18:35:13 INFO - Running pre-action listener: _resource_record_pre_action 18:35:13 INFO - Running main action method: populate_webroot 18:35:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:35:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:35:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:35:13 INFO - '--tppagecycles', 18:35:13 INFO - '7'], 18:35:13 INFO - 'tests': ['tsvgm']}}, 18:35:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:35:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:35:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:35:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:35:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:35:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:13 INFO - 'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:35:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:13 INFO - 'tests': ['damp', 'tps']}, 18:35:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:13 INFO - 'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['damp', 'tps']}, 18:35:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:35:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:35:13 INFO - 'other': {'tests': ['a11yr', 18:35:13 INFO - 'ts_paint', 18:35:13 INFO - 'tpaint', 18:35:13 INFO - 'sessionrestore', 18:35:13 INFO - 'sessionrestore_no_auto_restore']}, 18:35:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['a11yr', 18:35:13 INFO - 'ts_paint', 18:35:13 INFO - 'tpaint', 18:35:13 INFO - 'sessionrestore', 18:35:13 INFO - 'sessionrestore_no_auto_restore']}, 18:35:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['a11yr', 18:35:13 INFO - 'ts_paint', 18:35:13 INFO - 'tpaint', 18:35:13 INFO - 'sessionrestore', 18:35:13 INFO - 'sessionrestore_no_auto_restore']}, 18:35:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['a11yr', 18:35:13 INFO - 'ts_paint', 18:35:13 INFO - 'tpaint', 18:35:13 INFO - 'sessionrestore', 18:35:13 INFO - 'sessionrestore_no_auto_restore']}, 18:35:13 INFO - 'other_l64': {'tests': ['a11yr', 18:35:13 INFO - 'ts_paint', 18:35:13 INFO - 'tpaint', 18:35:13 INFO - 'sessionrestore', 18:35:13 INFO - 'sessionrestore_no_auto_restore']}, 18:35:13 INFO - 'other_nol64': {'tests': ['a11yr', 18:35:13 INFO - 'ts_paint', 18:35:13 INFO - 'tpaint', 18:35:13 INFO - 'sessionrestore', 18:35:13 INFO - 'sessionrestore_no_auto_restore']}, 18:35:13 INFO - 'svgr': {'tests': ['tsvgx', 18:35:13 INFO - 'tsvgr_opacity', 18:35:13 INFO - 'tart', 18:35:13 INFO - 'tscrollx', 18:35:13 INFO - 'cart']}, 18:35:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['tsvgx', 18:35:13 INFO - 'tsvgr_opacity', 18:35:13 INFO - 'tart', 18:35:13 INFO - 'tscrollx', 18:35:13 INFO - 'cart']}, 18:35:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:13 INFO - 'tests': ['tp5o']}, 18:35:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:13 INFO - 'talos_options': ['--e10s'], 18:35:13 INFO - 'tests': ['tp5o']}, 18:35:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:13 INFO - 'talos_options': ['--xperf_path', 18:35:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:35:13 INFO - 'tests': ['tp5n']}, 18:35:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:13 INFO - 'talos_options': ['--e10s', 18:35:13 INFO - '--xperf_path', 18:35:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:35:13 INFO - 'tests': ['tp5n']}}, 18:35:13 INFO - 'talos.zip': {'path': '', 18:35:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:35:13 INFO - Running post-action listener: _resource_record_post_action 18:35:13 INFO - ##### 18:35:13 INFO - ##### Running create-virtualenv step. 18:35:13 INFO - ##### 18:35:13 INFO - Running pre-action listener: _resource_record_pre_action 18:35:13 INFO - Running main action method: create_virtualenv 18:35:13 INFO - Creating virtualenv /builds/slave/test/build/venv 18:35:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:35:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:35:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:35:13 INFO - Using real prefix '/usr' 18:35:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:35:13 INFO - Installing distribute.............................................................................................................................................................................................done. 18:35:15 INFO - Installing pip.................done. 18:35:15 INFO - Return code: 0 18:35:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:35:15 INFO - Using env: {'DISPLAY': ':0', 18:35:15 INFO - 'HOME': '/home/cltbld', 18:35:15 INFO - 'LANG': 'en_US.UTF-8', 18:35:15 INFO - 'LANGUAGE': 'en_US:en', 18:35:15 INFO - 'LOGNAME': 'cltbld', 18:35:15 INFO - 'MAIL': '/var/mail/cltbld', 18:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:15 INFO - 'MOZ_NO_REMOTE': '1', 18:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:15 INFO - 'NO_EM_RESTART': '1', 18:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:15 INFO - 'PWD': '/builds/slave/test', 18:35:15 INFO - 'SHELL': '/bin/bash', 18:35:15 INFO - 'SHLVL': '1', 18:35:15 INFO - 'TERM': 'linux', 18:35:15 INFO - 'TMOUT': '86400', 18:35:15 INFO - 'USER': 'cltbld', 18:35:15 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:15 INFO - '_': '/tools/buildbot/bin/python'} 18:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:35:15 INFO - Cleaning up... 18:35:15 INFO - Return code: 0 18:35:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:35:15 INFO - Using env: {'DISPLAY': ':0', 18:35:15 INFO - 'HOME': '/home/cltbld', 18:35:15 INFO - 'LANG': 'en_US.UTF-8', 18:35:15 INFO - 'LANGUAGE': 'en_US:en', 18:35:15 INFO - 'LOGNAME': 'cltbld', 18:35:15 INFO - 'MAIL': '/var/mail/cltbld', 18:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:15 INFO - 'MOZ_NO_REMOTE': '1', 18:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:15 INFO - 'NO_EM_RESTART': '1', 18:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:15 INFO - 'PWD': '/builds/slave/test', 18:35:15 INFO - 'SHELL': '/bin/bash', 18:35:15 INFO - 'SHLVL': '1', 18:35:15 INFO - 'TERM': 'linux', 18:35:15 INFO - 'TMOUT': '86400', 18:35:15 INFO - 'USER': 'cltbld', 18:35:15 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:15 INFO - '_': '/tools/buildbot/bin/python'} 18:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:16 INFO - Downloading/unpacking psutil>=0.7.1 18:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:35:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:35:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:35:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:35:17 INFO - Installing collected packages: psutil 18:35:17 INFO - Running setup.py install for psutil 18:35:17 INFO - building 'psutil._psutil_linux' extension 18:35:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:35:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:35:18 INFO - building 'psutil._psutil_posix' extension 18:35:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:35:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:35:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:35:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:35:18 INFO - Successfully installed psutil 18:35:18 INFO - Cleaning up... 18:35:18 INFO - Return code: 0 18:35:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:18 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 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:35:18 INFO - Using env: {'DISPLAY': ':0', 18:35:18 INFO - 'HOME': '/home/cltbld', 18:35:18 INFO - 'LANG': 'en_US.UTF-8', 18:35:18 INFO - 'LANGUAGE': 'en_US:en', 18:35:18 INFO - 'LOGNAME': 'cltbld', 18:35:18 INFO - 'MAIL': '/var/mail/cltbld', 18:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:18 INFO - 'MOZ_NO_REMOTE': '1', 18:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:18 INFO - 'NO_EM_RESTART': '1', 18:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:18 INFO - 'PWD': '/builds/slave/test', 18:35:18 INFO - 'SHELL': '/bin/bash', 18:35:18 INFO - 'SHLVL': '1', 18:35:18 INFO - 'TERM': 'linux', 18:35:18 INFO - 'TMOUT': '86400', 18:35:18 INFO - 'USER': 'cltbld', 18:35:18 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:18 INFO - '_': '/tools/buildbot/bin/python'} 18:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:35:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:35:20 INFO - Installing collected packages: mozsystemmonitor 18:35:20 INFO - Running setup.py install for mozsystemmonitor 18:35:20 INFO - Successfully installed mozsystemmonitor 18:35:20 INFO - Cleaning up... 18:35:20 INFO - Return code: 0 18:35:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:20 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 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:35:20 INFO - Using env: {'DISPLAY': ':0', 18:35:20 INFO - 'HOME': '/home/cltbld', 18:35:20 INFO - 'LANG': 'en_US.UTF-8', 18:35:20 INFO - 'LANGUAGE': 'en_US:en', 18:35:20 INFO - 'LOGNAME': 'cltbld', 18:35:20 INFO - 'MAIL': '/var/mail/cltbld', 18:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:20 INFO - 'MOZ_NO_REMOTE': '1', 18:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:20 INFO - 'NO_EM_RESTART': '1', 18:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:20 INFO - 'PWD': '/builds/slave/test', 18:35:20 INFO - 'SHELL': '/bin/bash', 18:35:20 INFO - 'SHLVL': '1', 18:35:20 INFO - 'TERM': 'linux', 18:35:20 INFO - 'TMOUT': '86400', 18:35:20 INFO - 'USER': 'cltbld', 18:35:20 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:20 INFO - '_': '/tools/buildbot/bin/python'} 18:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:20 INFO - Downloading/unpacking blobuploader==1.2.4 18:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:22 INFO - Downloading blobuploader-1.2.4.tar.gz 18:35:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:35:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:35:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:23 INFO - Downloading docopt-0.6.1.tar.gz 18:35:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:35:23 INFO - Installing collected packages: blobuploader, requests, docopt 18:35:23 INFO - Running setup.py install for blobuploader 18:35:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:35:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:35:23 INFO - Running setup.py install for requests 18:35:23 INFO - Running setup.py install for docopt 18:35:23 INFO - Successfully installed blobuploader requests docopt 18:35:23 INFO - Cleaning up... 18:35:23 INFO - Return code: 0 18:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:23 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 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:35:23 INFO - Using env: {'DISPLAY': ':0', 18:35:23 INFO - 'HOME': '/home/cltbld', 18:35:23 INFO - 'LANG': 'en_US.UTF-8', 18:35:23 INFO - 'LANGUAGE': 'en_US:en', 18:35:23 INFO - 'LOGNAME': 'cltbld', 18:35:23 INFO - 'MAIL': '/var/mail/cltbld', 18:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:23 INFO - 'MOZ_NO_REMOTE': '1', 18:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:23 INFO - 'NO_EM_RESTART': '1', 18:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:23 INFO - 'PWD': '/builds/slave/test', 18:35:23 INFO - 'SHELL': '/bin/bash', 18:35:23 INFO - 'SHLVL': '1', 18:35:23 INFO - 'TERM': 'linux', 18:35:23 INFO - 'TMOUT': '86400', 18:35:23 INFO - 'USER': 'cltbld', 18:35:23 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:23 INFO - '_': '/tools/buildbot/bin/python'} 18:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:35:23 INFO - Running setup.py (path:/tmp/pip-FohzFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:35:24 INFO - Running setup.py (path:/tmp/pip-LOooKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:35:24 INFO - Running setup.py (path:/tmp/pip-E3jcZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:35:24 INFO - Running setup.py (path:/tmp/pip-5x9rH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:35:24 INFO - Running setup.py (path:/tmp/pip-buxw5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:35:24 INFO - Running setup.py (path:/tmp/pip-_ng0FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:35:24 INFO - Running setup.py (path:/tmp/pip-TD2fhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:35:24 INFO - Running setup.py (path:/tmp/pip-bljl4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:35:24 INFO - Running setup.py (path:/tmp/pip-YFhKS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:35:24 INFO - Running setup.py (path:/tmp/pip-LgNENY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:35:24 INFO - Running setup.py (path:/tmp/pip-NLkpdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:35:24 INFO - Running setup.py (path:/tmp/pip-ckX1QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:35:24 INFO - Running setup.py (path:/tmp/pip-ANCWH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:35:24 INFO - Running setup.py (path:/tmp/pip-45Ywvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:25 INFO - Running setup.py (path:/tmp/pip-i9lXM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:35:25 INFO - Running setup.py (path:/tmp/pip-KOaPaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:35:25 INFO - Running setup.py (path:/tmp/pip-GuI9zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:35:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:35:25 INFO - Running setup.py install for manifestparser 18:35:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Running setup.py install for mozcrash 18:35:25 INFO - Running setup.py install for mozdebug 18:35:25 INFO - Running setup.py install for mozdevice 18:35:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Running setup.py install for mozfile 18:35:25 INFO - Running setup.py install for mozhttpd 18:35:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Running setup.py install for mozinfo 18:35:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Running setup.py install for mozInstall 18:35:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:35:25 INFO - Running setup.py install for mozleak 18:35:26 INFO - Running setup.py install for mozlog 18:35:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:35:26 INFO - Running setup.py install for moznetwork 18:35:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:35:26 INFO - Running setup.py install for mozprocess 18:35:26 INFO - Running setup.py install for mozprofile 18:35:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:35:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:35:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:35:26 INFO - Running setup.py install for mozrunner 18:35:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:35:26 INFO - Running setup.py install for mozscreenshot 18:35:26 INFO - Running setup.py install for moztest 18:35:26 INFO - Running setup.py install for mozversion 18:35:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:35:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:35:26 INFO - Cleaning up... 18:35:26 INFO - Return code: 0 18:35:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:26 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 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:35:26 INFO - Using env: {'DISPLAY': ':0', 18:35:26 INFO - 'HOME': '/home/cltbld', 18:35:26 INFO - 'LANG': 'en_US.UTF-8', 18:35:26 INFO - 'LANGUAGE': 'en_US:en', 18:35:26 INFO - 'LOGNAME': 'cltbld', 18:35:26 INFO - 'MAIL': '/var/mail/cltbld', 18:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:26 INFO - 'MOZ_NO_REMOTE': '1', 18:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:26 INFO - 'NO_EM_RESTART': '1', 18:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:26 INFO - 'PWD': '/builds/slave/test', 18:35:26 INFO - 'SHELL': '/bin/bash', 18:35:26 INFO - 'SHLVL': '1', 18:35:26 INFO - 'TERM': 'linux', 18:35:26 INFO - 'TMOUT': '86400', 18:35:26 INFO - 'USER': 'cltbld', 18:35:26 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:26 INFO - '_': '/tools/buildbot/bin/python'} 18:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:35:27 INFO - Running setup.py (path:/tmp/pip-e6sKDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:35:27 INFO - Running setup.py (path:/tmp/pip-6XYSWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:35:27 INFO - Running setup.py (path:/tmp/pip-YCBPja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:35:27 INFO - Running setup.py (path:/tmp/pip-eAOA3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:35:27 INFO - Running setup.py (path:/tmp/pip-wxs1qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:35:27 INFO - Running setup.py (path:/tmp/pip-kJ6zpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:35:27 INFO - Running setup.py (path:/tmp/pip-lEso0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:35:27 INFO - Running setup.py (path:/tmp/pip-I_nBzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:35:27 INFO - Running setup.py (path:/tmp/pip-9RH1HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:35:27 INFO - Running setup.py (path:/tmp/pip-g_501N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:35:27 INFO - Running setup.py (path:/tmp/pip-Hjl1mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:35:27 INFO - Running setup.py (path:/tmp/pip-VosIRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:35:28 INFO - Running setup.py (path:/tmp/pip-XANFm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:35:28 INFO - Running setup.py (path:/tmp/pip-Pz1UD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:28 INFO - Running setup.py (path:/tmp/pip-4J61Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:35:28 INFO - Running setup.py (path:/tmp/pip-1_Kz7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:35:28 INFO - Running setup.py (path:/tmp/pip-ltPnx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:35:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:30 INFO - Downloading blessings-1.5.1.tar.gz 18:35:30 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:35:30 INFO - Installing collected packages: blessings 18:35:30 INFO - Running setup.py install for blessings 18:35:30 INFO - Successfully installed blessings 18:35:30 INFO - Cleaning up... 18:35:30 INFO - Return code: 0 18:35:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:35:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:35:30 INFO - Reading from file tmpfile_stdout 18:35:30 INFO - Current package versions: 18:35:30 INFO - argparse == 1.2.1 18:35:30 INFO - blessings == 1.5.1 18:35:30 INFO - blobuploader == 1.2.4 18:35:30 INFO - docopt == 0.6.1 18:35:30 INFO - manifestparser == 1.1 18:35:30 INFO - mozInstall == 1.12 18:35:30 INFO - mozcrash == 0.16 18:35:30 INFO - mozdebug == 0.1 18:35:30 INFO - mozdevice == 0.48 18:35:30 INFO - mozfile == 1.2 18:35:30 INFO - mozhttpd == 0.7 18:35:30 INFO - mozinfo == 0.9 18:35:30 INFO - mozleak == 0.1 18:35:30 INFO - mozlog == 3.1 18:35:30 INFO - moznetwork == 0.27 18:35:30 INFO - mozprocess == 0.22 18:35:30 INFO - mozprofile == 0.28 18:35:30 INFO - mozrunner == 6.11 18:35:30 INFO - mozscreenshot == 0.1 18:35:30 INFO - mozsystemmonitor == 0.0 18:35:30 INFO - moztest == 0.7 18:35:30 INFO - mozversion == 1.4 18:35:30 INFO - psutil == 3.1.1 18:35:30 INFO - requests == 1.2.3 18:35:30 INFO - wsgiref == 0.1.2 18:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:30 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 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:35:30 INFO - Using env: {'DISPLAY': ':0', 18:35:30 INFO - 'HOME': '/home/cltbld', 18:35:30 INFO - 'LANG': 'en_US.UTF-8', 18:35:30 INFO - 'LANGUAGE': 'en_US:en', 18:35:30 INFO - 'LOGNAME': 'cltbld', 18:35:30 INFO - 'MAIL': '/var/mail/cltbld', 18:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:30 INFO - 'MOZ_NO_REMOTE': '1', 18:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:30 INFO - 'NO_EM_RESTART': '1', 18:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:30 INFO - 'PWD': '/builds/slave/test', 18:35:30 INFO - 'SHELL': '/bin/bash', 18:35:30 INFO - 'SHLVL': '1', 18:35:30 INFO - 'TERM': 'linux', 18:35:30 INFO - 'TMOUT': '86400', 18:35:30 INFO - 'USER': 'cltbld', 18:35:30 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:30 INFO - '_': '/tools/buildbot/bin/python'} 18:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:35:30 INFO - Cleaning up... 18:35:30 INFO - Return code: 0 18:35:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:30 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 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:35:30 INFO - Using env: {'DISPLAY': ':0', 18:35:30 INFO - 'HOME': '/home/cltbld', 18:35:30 INFO - 'LANG': 'en_US.UTF-8', 18:35:30 INFO - 'LANGUAGE': 'en_US:en', 18:35:30 INFO - 'LOGNAME': 'cltbld', 18:35:30 INFO - 'MAIL': '/var/mail/cltbld', 18:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:30 INFO - 'MOZ_NO_REMOTE': '1', 18:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:30 INFO - 'NO_EM_RESTART': '1', 18:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:30 INFO - 'PWD': '/builds/slave/test', 18:35:30 INFO - 'SHELL': '/bin/bash', 18:35:30 INFO - 'SHLVL': '1', 18:35:30 INFO - 'TERM': 'linux', 18:35:30 INFO - 'TMOUT': '86400', 18:35:30 INFO - 'USER': 'cltbld', 18:35:30 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:30 INFO - '_': '/tools/buildbot/bin/python'} 18:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:31 INFO - Downloading/unpacking jsonschema 18:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:35:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:35:32 INFO - Downloading/unpacking functools32 (from jsonschema) 18:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:32 INFO - Downloading functools32-3.2.3-2.tar.gz 18:35:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:35:32 INFO - warning: no files found matching '*.txt' 18:35:32 INFO - no previously-included directories found matching 'build' 18:35:32 INFO - no previously-included directories found matching 'dist' 18:35:32 INFO - no previously-included directories found matching '.git*' 18:35:32 INFO - Installing collected packages: jsonschema, functools32 18:35:33 INFO - Running setup.py install for functools32 18:35:33 INFO - warning: no files found matching '*.txt' 18:35:33 INFO - no previously-included directories found matching 'build' 18:35:33 INFO - no previously-included directories found matching 'dist' 18:35:33 INFO - no previously-included directories found matching '.git*' 18:35:33 INFO - Successfully installed jsonschema functools32 18:35:33 INFO - Cleaning up... 18:35:33 INFO - Return code: 0 18:35:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:33 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 0x7fa2bc449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, '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': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:35:33 INFO - Using env: {'DISPLAY': ':0', 18:35:33 INFO - 'HOME': '/home/cltbld', 18:35:33 INFO - 'LANG': 'en_US.UTF-8', 18:35:33 INFO - 'LANGUAGE': 'en_US:en', 18:35:33 INFO - 'LOGNAME': 'cltbld', 18:35:33 INFO - 'MAIL': '/var/mail/cltbld', 18:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:33 INFO - 'MOZ_NO_REMOTE': '1', 18:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:33 INFO - 'NO_EM_RESTART': '1', 18:35:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:33 INFO - 'PWD': '/builds/slave/test', 18:35:33 INFO - 'SHELL': '/bin/bash', 18:35:33 INFO - 'SHLVL': '1', 18:35:33 INFO - 'TERM': 'linux', 18:35:33 INFO - 'TMOUT': '86400', 18:35:33 INFO - 'USER': 'cltbld', 18:35:33 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:33 INFO - '_': '/tools/buildbot/bin/python'} 18:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:33 INFO - Downloading/unpacking flake8 18:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:35:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:35:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:35:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:35:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:35:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:35:35 INFO - no previously-included directories found matching 'docs/_build' 18:35:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:35:35 INFO - Running setup.py install for pep8 18:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:35:35 INFO - no previously-included directories found matching 'docs/_build' 18:35:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:35:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:35:35 INFO - Cleaning up... 18:35:35 INFO - Return code: 0 18:35:35 INFO - Running post-action listener: _resource_record_post_action 18:35:35 INFO - Running post-action listener: _start_resource_monitoring 18:35:36 INFO - Starting resource monitoring. 18:35:36 INFO - ##### 18:35:36 INFO - ##### Running install step. 18:35:36 INFO - ##### 18:35:36 INFO - Running pre-action listener: _resource_record_pre_action 18:35:36 INFO - Running main action method: install 18:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:35:36 INFO - Reading from file tmpfile_stdout 18:35:36 INFO - Detecting whether we're running mozinstall >=1.0... 18:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:35:36 INFO - Reading from file tmpfile_stdout 18:35:36 INFO - Output received: 18:35:36 INFO - Usage: mozinstall [options] installer 18:35:36 INFO - Options: 18:35:36 INFO - -h, --help show this help message and exit 18:35:36 INFO - -d DEST, --destination=DEST 18:35:36 INFO - Directory to install application into. [default: 18:35:36 INFO - "/builds/slave/test"] 18:35:36 INFO - --app=APP Application being installed. [default: firefox] 18:35:36 INFO - mkdir: /builds/slave/test/build/application 18:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:35:51 INFO - Reading from file tmpfile_stdout 18:35:51 INFO - Output received: 18:35:51 INFO - /builds/slave/test/build/application/firefox/firefox 18:35:51 INFO - Running post-action listener: _resource_record_post_action 18:35:51 INFO - ##### 18:35:51 INFO - ##### Running run-tests step. 18:35:51 INFO - ##### 18:35:51 INFO - Running pre-action listener: _resource_record_pre_action 18:35:51 INFO - Running main action method: run_tests 18:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:35:51 INFO - Python 2.7.3 18:35:51 INFO - Return code: 0 18:35:51 INFO - grabbing minidump binary from tooltool 18:35: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')]} 18:35:51 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 0x114b3d0>, '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 0x10b6ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:35:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:35:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:35:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:35:52 INFO - Return code: 0 18:35:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:35:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:35:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:35:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:35:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:35:52 INFO - Return code: 0 18:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:35:52 INFO - Using env: {'DISPLAY': ':0', 18:35:52 INFO - 'HOME': '/home/cltbld', 18:35:52 INFO - 'LANG': 'en_US.UTF-8', 18:35:52 INFO - 'LANGUAGE': 'en_US:en', 18:35:52 INFO - 'LOGNAME': 'cltbld', 18:35:52 INFO - 'MAIL': '/var/mail/cltbld', 18:35:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:35:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:52 INFO - 'MOZ_NO_REMOTE': '1', 18:35:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:52 INFO - 'NO_EM_RESTART': '1', 18:35:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:52 INFO - 'PWD': '/builds/slave/test', 18:35:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:35:52 INFO - 'SHELL': '/bin/bash', 18:35:52 INFO - 'SHLVL': '1', 18:35:52 INFO - 'TERM': 'linux', 18:35:52 INFO - 'TMOUT': '86400', 18:35:52 INFO - 'USER': 'cltbld', 18:35:52 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439', 18:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:52 INFO - '_': '/tools/buildbot/bin/python'} 18:35:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:35:53 INFO - mozversion application_buildid: 20160113171930 18:35:53 INFO - mozversion application_changeset: c970bca8297d3a6e348c539b8cb9aa68e19087be 18:35:53 INFO - mozversion application_display_name: Nightly 18:35:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:35:53 INFO - mozversion application_name: Firefox 18:35:53 INFO - mozversion application_remotingname: firefox 18:35:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:35:53 INFO - mozversion application_vendor: Mozilla 18:35:53 INFO - mozversion application_version: 46.0a1 18:35:53 INFO - mozversion platform_buildid: 20160113171930 18:35:53 INFO - mozversion platform_changeset: c970bca8297d3a6e348c539b8cb9aa68e19087be 18:35:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:35:53 INFO - mozversion platform_version: 46.0a1 18:35:53 INFO - using testdate: 1452738953 18:35:53 INFO - actual date: 1452738953 18:35:53 INFO - starting webserver on 'localhost:38081' 18:35:53 INFO - SUITE-START | Running 3 tests 18:35:53 INFO - TEST-START | dromaeo_css 18:35:53 INFO - operating with platform_type : linux_ 18:35:53 INFO - Initialising browser for dromaeo_css test... 18:35:53 INFO - TEST-INFO | started process 15896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS_hi0F/profile http://localhost:38081/getInfo.html) 18:35:57 INFO - PROCESS | 15896 | 18:35:57 INFO - PROCESS | 15896 | (process:15984): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:35:58 INFO - PROCESS | 15896 | __metrics Screen width/height:1600/1200 18:35:58 INFO - PROCESS | 15896 | colorDepth:24 18:35:58 INFO - PROCESS | 15896 | Browser inner width/height: 1024/697 18:35:58 INFO - PROCESS | 15896 | __metrics 18:35:58 INFO - PROCESS | 15896 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:35:59 INFO - TEST-INFO | 15896: exit 0 18:35:59 INFO - Browser initialized. 18:35:59 INFO - Running cycle 1/1 for dromaeo_css test... 18:35:59 INFO - TEST-INFO | started process 16033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS_hi0F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:36:00 INFO - PROCESS | 16033 | 18:36:00 INFO - PROCESS | 16033 | (process:16091): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:36:11 INFO - PROCESS | 16033 | RSS: Main: 151060480 18:36:11 INFO - PROCESS | 16033 | 18:37:00 INFO - PROCESS | 16033 | 1452739020762 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:39:11 INFO - PROCESS | 16033 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38081/tests/dromaeo/cssquery-ext.html) 18:39:13 INFO - PROCESS | 16033 | RSS: Main: 154525696 18:39:13 INFO - PROCESS | 16033 | 18:42:15 INFO - PROCESS | 16033 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-ext.html (next: http://localhost:38081/tests/dromaeo/cssquery-jquery.html) 18:42:15 INFO - PROCESS | 16033 | RSS: Main: 151736320 18:42:15 INFO - PROCESS | 16033 | 18:45:17 INFO - PROCESS | 16033 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38081/tests/dromaeo/cssquery-mootools.html) 18:45:18 INFO - PROCESS | 16033 | RSS: Main: 150863872 18:45:18 INFO - PROCESS | 16033 | 18:48:20 INFO - PROCESS | 16033 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38081/tests/dromaeo/cssquery-prototype.html) 18:48:20 INFO - PROCESS | 16033 | RSS: Main: 150900736 18:48:20 INFO - PROCESS | 16033 | 18:51:23 INFO - PROCESS | 16033 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38081/tests/dromaeo/cssquery-yui.html) 18:51:24 INFO - PROCESS | 16033 | RSS: Main: 150339584 18:51:24 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | Cycle 1(1): loaded http://localhost:38081/tests/dromaeo/cssquery-yui.html (next: http://localhost:38081/tests/dromaeo/cssquery-dojo.html) 18:54:26 INFO - PROCESS | 16033 | RSS: Main: 152297472 18:54:26 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | __start_tp_report 18:54:26 INFO - PROCESS | 16033 | _x_x_mozilla_page_load 18:54:26 INFO - PROCESS | 16033 | _x_x_mozilla_page_load_details 18:54:26 INFO - PROCESS | 16033 | |i|pagename|runs| 18:54:26 INFO - PROCESS | 16033 | |0;dojo.html;2624.6325514427995;2632.710401855796;2650.2844232057346;2665.746754058364;2669.919902402928;4363.367311739804;4419.801108950093;4438.13456376006;4453.977730111349;4500.16746901823;4480.350349199364;4556.179887620227;4562.543745625436;4599.425071866017;4620.237660785966;4227.809748561307;4231.597998190167;4295.742255464666;4311.762853043081;4325.52419233884;4156.981539522822;4159.334506478964;4210.578942105795;4232.3016702244095;4256.148770245948;4110.260153172428;4167.729097608676;4201.138766552849;4204.873853784391;4277.572242775728;4182.790860456965;4204.789760511962;4204.810783514749;4221.155768846243;4249.660027197817;4209;4215.178040282146;4227.175700738358;4228.069824638575;4229.577042295746;4339.544347843463;4418.867433976986;4434.711743736679;4448.154850578379;4464.6874718769695;4768.260919557474;4872.537108974641;4906.067847109038;4933.407991041062;4963.751812409365;4936.456989731127;4943.678660887031;4955.98402327522;4960.305557221992;5003;4385.934210986838;4474.284114541722;4563.133004729091;4590.563896429834;4651.395318608593;4985.476524964826;5032.6980381177245;5033.219850923113;5051.595872330205;5071.18860982241;4740.075685241345;4742.075295317449;4747.620190384761;4747.8100875965265;4793.376861008116;4758.547937945889;4830.855074347775;4831;4839.540243676845;4887.462379138292;4757.976210118927;4765.309030190603;4787.257975013878;4793.664443488992;4811.374521312207;4714.882127946828;4728.621710263171;4733.763311834395;4754.334393184957;4778.689385189951;3981.323175060189;3981.601839816053;3991.560928297885;3993.7004724645767;4034.838606455709;3528.5060091587197;3580.820958952042;3607.9278414432088;3614.945775813365;3621.9818900905852;4178.1643671265265;4202.327627579633;4214.241436541452;4220.873373798791;4242.851500197478;4773.37946067016;4783.425988881357;4827.08285425768;4845.878853028632;4888.682235654742;4276.2516559601945;4302.419173411612;4310.181065597589;4318.546552611993;4333.306670932636;4199.685023623179;4244.957550424518;4256.616904478612;4269.402283680287;4291.163223171452;4444.7110937789585;4516.006478574774;4530.501644819067;4559.498455169863;4592.3570700101345;4882.352649605762;4883.755812209304;4917.213245880642;4921.261810728276;4928.112939670894;4639.791209395517;4656.813727451;4660.580547750718;4662.0675864827845;4692.0146769178855;4625.098105869323;4697.741624210565;4797.2564252540915;4819.975900120477;4855.077535268288;4893.143699852582;4901.068796928572;4903.509649035068;4919.2129259318335;4963.404391473046;4697.849026988273;4722.220833562424;4746.572808447257;4757.143714131351;4803.903921921472;4618.076384723136;4684.039771846695;4700.9529904701885;4741.383620129499;4763.261694437368;4644.419447569054;4653.418322709661;4659.953400466087;4682.789274482589;4733.5266473352385;4580.083983203306;4797.160496912957;4809.350737650372;4818.68678535894;4851.708897466164;4604.815807367668;4618.930716039329;4626.676132670681;4626.982063945927;4683.718976861399 18:54:26 INFO - PROCESS | 16033 | |1;ext.html;454.8862784303924;471.6227018385289;473.621103117506;476.99830356251874;498.88026873550314;31554.36891262176;32140.196495087635;32164.839175804118;32236.355272894558;32301;34917.301653966904;35668.10829729258;35723.4641480378;35757.46363804545;35786.2842743145;7614.657340419667;7812.648430820626;7813.726519571816;7815.452918295721;7822.765317040498;7327.230640782721;7414.851702965964;7417.184109747924;7439.107307123153;7453.81365465865;7568.848623027536;7622.390208783312;7650.655720492591;7668;7686.730964416247;7555.7733268001775;7589.658465369016;7600.201978792203;7604.847903041964;7604.885926711104;7681.116671582784;7848.45060845741;7879.960600196962;7883.408744344197;7885.29032387088;35251.82374088113;35777.46333804995;35892.46161307582;35901;35923.4611480828;2381.0594365591987;2831.830090194595;2870.7559857412143;3013;3559.1458050068054;24862.50274994508;25781.484370312675;26087.217383478524;26150;26840;3217.6460589335156;3272.936295703882;3328.517364982088;3394.6435624259593;3432.6052503962114;177285;178675;179591.10204449156;179671;179777;45285.54714452814;46441.071178576916;49018.26472602914;52455;53271.73364133154;53379;53579.73210134002;53768.19347709788;54003.18995215075;54027.459725402245;13716.108452950526;13738.86261137376;13842.653933651538;13844.10013349129;13845.653858653613;10289.74275643115;10305.278630495794;10326.896731032744;10329.276950613536;10340.844887326695;18207.81792182088;18310.63378732418;18459.353922612645;18471.261149554135;18479.81520184781;7156.785296441115;7483.8503229935095;7489.588072656056;7603.581803000778;7652.196519365498;822.042320696382;830.7050996896136;840.1178762299561;869.8042940338373;886.2289807867197;25991.592396167;26227.426354418796;26301.47397052048;26330.6050409244;26379.208623741317;972.0619602084023;1017.4404077757204;1032.2413026425572;1043.1811028342715;1048.1509976918721;13714.588562343146;13793;13823.861761382459;13935.790963135561;13941.721165576631;263969;266219;267611;268944;269038;44861.327080093826;45878;46082.30876536854;46174;46299;1206.9818952715716;1214.2435530512291;1222.4254600337827;1233.3709807997807;1236.0914727675151;25158.62262066107;25620.35949101213;25705.871470642527;25828;25911.611325829752;39824.60175398209;40307.1938561233;40310.79844600758;40311;40429.1914161721;249387;250674;250681;252305;253499;28444.57333140046;28748;28892.711072889004;28918.855405722836;29081.418371632026;32961.505577415875;32988.50517242291;33769;33904;34041.82979085188;27172.72827271702;27430.725692742817;27672.861635691694;27825.582616261177;27859.303517412227;28297.57553636738;28359.149225523266;28374.432511349245;28572.57141142843;29129;30912.0726378209;31364.529532056582;31504.842475787475;31668.524972124975;31859.36281274315;27114.864425678534;28465.857670711513;29237;30976.69023309828;32595.348093037534;23147.4213144666;24574.139905103235;25305.691113647983;25325.62011569791;25328.366790830376 18:54:26 INFO - PROCESS | 16033 | |2;jquery.html;337.87498625508556;339.9762016658835;340.04786597526925;341.22031158802145;342.8851334802841;13573.457061717532;14121.858781412182;14595.270236488159;14848.480303189377;15368.692626147471;13419.396127174276;13500.729985400287;14462.638434039154;14482.131072135679;14485.130892146452;4350.108227813299;4370.366296886949;4552.567506086916;4556.476005259405;4559.293309537027;4438.068005718803;4520.389747384094;4528.75091869947;4547.340635607835;4549.909001819961;4317.287647538153;4404.053128577355;5205.531502164805;5412.377576578685;5414.512693857552;5044.747762611892;5195.584353251731;5230;5242.685438873642;5244.344456942901;5020.874478138039;5027.195648696227;5030.8239211627415;5035.269885866529;5053.065182941167;16904.746428803577;17490.95054296746;17511.387101451517;18208;18276.268949242014;1694.6187107900746;1706.9487915362558;1739.7908453624736;1774.5208793625777;1802.0809387212616;8349.707760228424;8660.566971651393;8725.869111963326;9178.357514973955;11495.367754773484;1665.3671604790222;1707.3170731707291;1714.588498760301;1753.6755700195376;1824.6077093424976;47626.76186619045;47951.52048479505;49050;49931.999999999636;51338;9640.807183856283;9694.854577181348;9710.028997100233;9718.951405242928;9783.46190959504;12212.633620991384;12227.938860305641;12334.876651233551;12355.25868447896;12368.257904525757;6525.412712855771;6556.18047744032;6598.208215014229;6622.37087476689;6636.966815165893;6122.173506576644;6173.32093469718;6175.320714721377;6197.442230199304;6225.906611400833;4163.770992595376;4186.7278626889765;4196.160767846443;4204.51648060477;4212.957870421318;1602.094816428714;1675.1791622105081;1714.8244025797223;1730.8788384813195;1743.4246698589436;782.8786538086606;847.4660963592897;856.5545916123706;873.9388242822941;941.6845356805546;13681.31593420325;13893.374798134108;14064.578062658136;14237.572872813833;14389.28053597316;785.9764207073797;804.481109684262;808.2362167751536;822.5188264865001;824.6660102658433;7878.094019187753;7928.841423171504;7983.800404989922;8423.452475589189;8442.282405995436;312039;319647;425843;432428;437455;38800.22399551993;44192.55807441949;61401.38598613957;62627.68686156631;63860.68069659622;1011.6256984915628;1030.577463240083;1034.131329683055;1047.3035431438161;1059.7191744187796;12910.354482276036;13350.465981360638;13547.187168769511;13703.040787144804;13911.930440347733;26294.211173664822;26692;27255;27470;28270;33551.16122096967;34331.313373731886;35432;35822;35867.10332241715;6534.8366290843105;6622.37087476689;6748.865022699617;6757.358050985148;6892.827679308058;8625.353098517511;8795.516246606498;9517.381370210915;9771.902280977383;9774.364666296668;7970.362371010421;8562.48625082472;8665.220130188314;8675.219230269306;8713.25937295337;8455;8537.624230951105;8701.390902636755;8930.285577153942;9142.497162656118;6295;6565.507586930904;6842.794716158523;7026.437884969088;7162.89255661176;8267.379946504156;8680;8688.348373871859;8814.427062240933;8826.867596985921;8486.448380855225;8586.656533738831;8680.609372578123;8707.738767836974;8751.343649226206 18:54:26 INFO - PROCESS | 16033 | |3;mootools.html;1334.9532766353177;1340.705044890124;1441.4378392426956;1668.883178177528;1694.3053348127262;6099.969500152504;6146.262448506174;6550.705218265178;6609.339066093395;6639.3692599203;6552.934470655292;6686.431653309474;6728.730850765975;6762.830929226772;6767.76312829051;2051.846111541633;2081.9902347361594;2083.927062552811;2086.1655337864822;2087.4781304673834;2025.8581899267058;2048.1807277089133;2065.4423305707523;2099.4751312171957;2104.9579008419823;2058.9176432942663;2060.453979695382;2065.5249292662697;2077.158750705959;2078.085642317383;2015.9092840822125;2035.2571311471354;2038.042120203502;2039.8576796993732;2041.530447996954;2047.3346162497248;2057.0537552725764;2087.8016588424075;2092.95814083719;2094.277474271374;7065.505414620979;7066.611336376497;7069.9646501767675;7070.29297070294;7103.89344159838;3975.0857302820223;4096.446979657768;4097.959020409788;4099.262132816092;4130.339145736698;2650.681918169832;2651.615515750225;2687.4490729400427;2694.245611228859;2714.742099500544;777.7277952716561;779.1312686354673;784.329398364396;811.119934870666;813.5810057820228;9400.717978460725;9437.811243775155;9441.055894410572;9450.716478505656;9472.384295020871;3735.9912823537493;3780.584135745066;3812.4471951566866;3818.3890577507464;3843.0392401899526;8058.11360750317;8078.596070196584;8081.151479094728;8102.108768035511;8119.3910456715985;4140.358244472111;4154.065335299594;4182.456280683492;4190.434291370626;4210.410542524049;3218.1954511372155;3275.066606017321;3632.5096112025067;3787.5265591801026;3812.1803812180515;3259.4947783093658;3290.341931613687;3298.290867463507;3320.833958302075;3324.700776930088;1003.0420947994647;1010.5907107621425;1012.2964539645023;1015.9796804064025;1020.2144348851343;869.5000374784524;881.1276835932381;979.8726165598426;1011.5801942193907;1019.7807471393686;6296.087067375205;6325.620462772156;6507.479401647857;6664.433523150489;6681.331866813377;1006.5219020965129;1006.6225165562914;1028.1980055556678;1040.8282633365409;1049.1134990932803;5008.499150085036;5128.692278463304;5129.563987061141;5140.640155189176;5143.6399452037995;8038.718644847402;8409.789755256044;8672.95663521691;8767.956160219286;8800;7901.328387087047;7969.282764551218;7976.5612891290375;8011.158828322942;8016.438849280611;6633.767818126343;6757.729690812313;6778.830529236809;6789.6605169741315;6818.2159051708695;6135.233095863017;6200.3489633589625;6304.65324407162;6323.1463752394675;6338.841528961812;7173.569585824867;7338.156112047183;7374.557526548424;7397.741079062207;7438.962805185939;7368.484206105735;7464.440166987389;7524.623768811647;7617.65720542588;7680.577568233801;5258.158694608845;5470.617056805985;6222.160008398808;6330.39861213184;6337.7781777637565;6264.154339164154;6347.301796802256;6347.301796802441;6393.29673735898;6414.454771344488;5985.221921150222;6037.366076561898;6113.847153821012;6193.876122477435;6206.627602343874;6127.295361033538;6133.969330153321;6137.41694539018;6181.474574661204;6251.156093927261;6179.969100154471;6206.968965155145;6220.968895155495;6222;6236.875262494634;5680.204771331934;5710.65736055838;5724.627899186539;5725.828225153252;5732.340780810094;5996.280446346466;6079.179310792986;6086;6100.938990610037;6103.786367477117 18:54:26 INFO - PROCESS | 16033 | |4;prototype.html;297.81981900949927;309.37351862478477;310.3637543036774;313.1513598149016;313.87288148299945;5409.486098820616;5463.535599474049;5521.392646808853;5563.193336966137;5604.8038318658855;5407.270018547495;5444.373897001846;5484.945150548493;5485.780568777254;5487.314085739283;4138.7516748995;4193.077522944947;4203.180379825935;4223.3031549794405;4228.682848786338;4196.580341965794;4204.97897510512;4218.683598730092;4221.2190744712325;4224.366345048236;4178.6657067434535;4183.184279065584;4183.184279065584;4184.790760461965;4214.7681877496725;4213.988642725754;4218.620324170839;4225.978870105645;4233.386159006942;4233.851815186485;3553.5558055243096;3680.3191409589044;3703.925921481582;3704.7777133372083;3707.4253490708984;5176.663516871429;5269.552088072518;5288.709120998344;5293.86765330866;5321.627486075976;4813.518648135194;4813.975930120327;4820.783064762094;4823.3729615149805;4826.879328016793;5772.451617096411;5784.4504772046585;5798.594098413113;5798.623089499211;5807.941920580783;3880.805959702032;3936.252112098692;3975.7216994810374;3977.8209980550946;3993.5407428145845;6014.488768454687;6046.606970546901;6048.8185354439;6051.1225872248715;6092;4060.1067765091634;4067.247559201557;4070.2673518766906;4070.776107314067;4087.4686290782006;4191.559886211965;4194.517630472474;4200.789960501963;4200.873973780792;4218.578142185757;4586.2661974083985;4764.523547645277;4766.45185803637;4776.426828780569;4781.42622885256;5638.2670252866865;5723.885522289531;5734.770609175586;5805.187273781674;5821.359650438449;1441.8558144185497;1468.8898332624883;1469.4489566412594;1470.3383477434984;1473.528470889305;973.1825266775942;973.3721749471551;989.8861630912537;993.5975929748463;1003.3327836988321;5058.392992840809;5063.468335824759;5100.056489549445;5100.69395836251;5109.233614957711;5939.70301484924;5985.790497332572;5985.850353741104;5990.760369585255;5991.5206783457215;5043.293938848564;5055.797768089235;5069.239614057847;5069.5690866276045;5099.949000509948;3175.25381535339;3221.098092534094;3251.772375933662;3261.6249131349723;3264.4124057669846;5626.831195064155;5633.521150702154;5643.01247281724;5643.097104463266;5663.716814159358;6136.447719705248;6150.04674275488;6165.414285642857;6171.413715697002;6175.536834737412;5511.807086751945;5647.29408823897;5655.1799989001365;5672.773089076473;5677.233573467612;5975.970120149372;5986.102084687332;5989.131575921379;5995.16067750524;6001.319630503466;5860.765569377178;5861.560382971209;5866.2960444746905;5882.411758824083;5890.381509941394;5631.324241091095;5652.152177173457;5655.179998900054;5658;5673.914891276717;4066.6543343816106;4101.876943691694;4146.937795933003;4150.91698166029;4159.313713237282;5902.557308201816;5962.9105563415715;5969.850753731192;5972.522198224218;6055.727492262947;5845.503132233808;5860.941390586039;5865.560082993878;5874.001419758566;5874.324452687995;5811.418858114154;5817.680027598522;5820.679862607428;5828.708564571839;5832.183494310885;5587.357453892691;5651.095824668033;5707.086866101404;5710.2576665033275;5711.971440142773;5849.415058494286;5851.834821116215;5859.296884373903;5871.178035075008;5873.148393482836;5630.85922851932;5675.0636145035605;5684.403137670485;5685.175649530877;5685.630434021776 18:54:26 INFO - PROCESS | 16033 | |5;yui.html;697.3166297028912;721.6824597177242;767.5394763142114;768.9884651730222;770.5800338815345;11541.076713862893;11660.708482287948;11705;11725.47235374408;11762.705932351684;11509.079273658108;11570.710732231699;11592.710182245448;11597.3041617503;11619.12856535759;589.0339842658044;599.7780821096201;757.6969212315063;761.8247803005312;769.3883362726618;765.9770206893802;770.8959290495795;773.0877564473918;775.6276987046222;776.5301992294637;798.932090772285;799.7760627024443;802.3781569283793;802.4342838298985;802.5265093594778;791.3036527855479;794.8370584030289;795.6658203554521;796.1004065406054;797.2466019611469;593.2791658135343;594.1266338482424;594.3195041677299;594.7769586405099;594.8156071617813;11523.711907202303;11537.307761534335;11570.363630000347;11599.94200029003;11650.533978640844;11957.760844783143;12115.757684846341;12201.755964880742;12398;12414.131010829245;9252.398594091363;9508.144267016001;9584.185344245678;9766.804663906682;9813.018698130201;3191.4734068878606;3268.656791036931;3281.917952051194;3295;3331.800091994488;36127.4580881287;36339.4549081764;36346.27307453863;36362.63637363619;36614.45078323827;9106.772330691785;9208.171264586086;9409.71770846862;9414.858777118348;9426.340156189139;15953.760693589606;15976.201189940457;15978.201089945456;15994.680106397807;15997.200139992954;6292.685365731695;6296.212973378328;6323.810285691437;6379.202599675041;6562;3608.891733248007;3661.1030297577263;3706.4440333949583;3738.8691395801015;3768.792716400624;2558.539462896659;2568.7284794026705;2570.8200425970376;2580.9225723228333;2596.9091081812044;465.64843543125403;469.70408642555657;474.15126922808474;474.5254745254745;475.4366076199714;470.934069230308;505.54248405193357;575.7610591604438;586.8503531599415;598;8193.549354785544;8450;8497.192766687278;8498.957505212558;8629.870551941725;452.32377595494944;479.4749749024812;529.9920501192486;581.994180058194;624.188554878656;3462.6364231755806;3540.1149712571855;3623.61951995042;3627.945580816237;3705.2219034002624;45538;50445.49554504408;50539.49460505348;50609;50778;43451.56548434538;43830.34254486185;44219.55780442154;44442.77778611086;44494.11011779746;38624.613753862664;38894.41658375126;39320.60679393169;39403.802980985485;40130;7206.963965180141;7240.818979525554;7290.854182916418;7329.963350183215;7512.511686740344;27740.445191096467;28357.43285134327;28368.574471382533;28728.712712872602;28841.7115828839;36521.81739091394;38084.238315232986;38157.80921095377;38504.80747596244;38757.224855502165;8624.568771561522;8627.43921645091;8743.12568743146;8781.077986811548;9021.90978090237;10056.89943100589;10236.385816851012;10274.537645805807;10361.4301213434;10685.679429617125;9138.347463944345;9179.541022948959;9252.583633736363;9430.339876208875;9554.331196816434;9324.766880828034;9367.297452691211;9477.194438472807;9588.856167157359;9664.661736839176;9572.664956726481;9588.712338629852;9695.272854536079;9868.062534059252;10087.3443226193;7597.962010189914;7792.844143116992;7801.609919503889;7857.882131768142;7897.644605992629;7669.923300767144;7842;8171.223733745284;9168.266538677024;9187.310951678517 18:54:26 INFO - PROCESS | 16033 | __end_tp_report 18:54:26 INFO - PROCESS | 16033 | __start_cc_report 18:54:26 INFO - PROCESS | 16033 | _x_x_mozilla_cycle_collect,334 18:54:26 INFO - PROCESS | 16033 | __end_cc_report 18:54:26 INFO - PROCESS | 16033 | __startTimestamp1452740066527__endTimestamp 18:54:26 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | ------- Summary: start ------- 18:54:26 INFO - PROCESS | 16033 | Number of tests: 6 18:54:26 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | [#0] dojo.html Cycles:165 Average:4490.42 Median:4620.24 stddev:457.85 (9.9%) stddev-sans-first:435.23 18:54:26 INFO - PROCESS | 16033 | Values: 2624.6 2632.7 2650.3 2665.7 2669.9 4363.4 4419.8 4438.1 4454.0 4500.2 4480.4 4556.2 4562.5 4599.4 4620.2 4227.8 4231.6 4295.7 4311.8 4325.5 4157.0 4159.3 4210.6 4232.3 4256.1 4110.3 4167.7 4201.1 4204.9 4277.6 4182.8 4204.8 4204.8 4221.2 4249.7 4209.0 4215.2 4227.2 4228.1 4229.6 4339.5 4418.9 4434.7 4448.2 4464.7 4768.3 4872.5 4906.1 4933.4 4963.8 4936.5 4943.7 4956.0 4960.3 5003.0 4385.9 4474.3 4563.1 4590.6 4651.4 4985.5 5032.7 5033.2 5051.6 5071.2 4740.1 4742.1 4747.6 4747.8 4793.4 4758.5 4830.9 4831.0 4839.5 4887.5 4758.0 4765.3 4787.3 4793.7 4811.4 4714.9 4728.6 4733.8 4754.3 4778.7 3981.3 3981.6 3991.6 3993.7 4034.8 3528.5 3580.8 3607.9 3614.9 3622.0 4178.2 4202.3 4214.2 4220.9 4242.9 4773.4 4783.4 4827.1 4845.9 4888.7 4276.3 4302.4 4310.2 4318.5 4333.3 4199.7 4245.0 4256.6 4269.4 4291.2 4444.7 4516.0 4530.5 4559.5 4592.4 4882.4 4883.8 4917.2 4921.3 4928.1 4639.8 4656.8 4660.6 4662.1 4692.0 4625.1 4697.7 4797.3 4820.0 4855.1 4893.1 4901.1 4903.5 4919.2 4963.4 4697.8 4722.2 4746.6 4757.1 4803.9 4618.1 4684.0 4701.0 4741.4 4763.3 4644.4 4653.4 4660.0 4682.8 4733.5 4580.1 4797.2 4809.4 4818.7 4851.7 4604.8 4618.9 4626.7 4627.0 4683.7 18:54:26 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | [#1] ext.html Cycles:180 Average:38447.48 Median:31611.45 stddev:61458.55 (194.4%) stddev-sans-first:61564.75 18:54:26 INFO - PROCESS | 16033 | Values: 454.9 471.6 473.6 477.0 498.9 31554.4 32140.2 32164.8 32236.4 32301.0 34917.3 35668.1 35723.5 35757.5 35786.3 7614.7 7812.6 7813.7 7815.5 7822.8 7327.2 7414.9 7417.2 7439.1 7453.8 7568.8 7622.4 7650.7 7668.0 7686.7 7555.8 7589.7 7600.2 7604.8 7604.9 7681.1 7848.5 7880.0 7883.4 7885.3 35251.8 35777.5 35892.5 35901.0 35923.5 2381.1 2831.8 2870.8 3013.0 3559.1 24862.5 25781.5 26087.2 26150.0 26840.0 3217.6 3272.9 3328.5 3394.6 3432.6 177285.0 178675.0 179591.1 179671.0 179777.0 45285.5 46441.1 49018.3 52455.0 53271.7 53379.0 53579.7 53768.2 54003.2 54027.5 13716.1 13738.9 13842.7 13844.1 13845.7 10289.7 10305.3 10326.9 10329.3 10340.8 18207.8 18310.6 18459.4 18471.3 18479.8 7156.8 7483.9 7489.6 7603.6 7652.2 822.0 830.7 840.1 869.8 886.2 25991.6 26227.4 26301.5 26330.6 26379.2 972.1 1017.4 1032.2 1043.2 1048.2 13714.6 13793.0 13823.9 13935.8 13941.7 263969.0 266219.0 267611.0 268944.0 269038.0 44861.3 45878.0 46082.3 46174.0 46299.0 1207.0 1214.2 1222.4 1233.4 1236.1 25158.6 25620.4 25705.9 25828.0 25911.6 39824.6 40307.2 40310.8 40311.0 40429.2 249387.0 250674.0 250681.0 252305.0 253499.0 28444.6 28748.0 28892.7 28918.9 29081.4 32961.5 32988.5 33769.0 33904.0 34041.8 27172.7 27430.7 27672.9 27825.6 27859.3 28297.6 28359.1 28374.4 28572.6 29129.0 30912.1 31364.5 31504.8 31668.5 31859.4 27114.9 28465.9 29237.0 30976.7 32595.3 23147.4 24574.1 25305.7 25325.6 25328.4 18:54:26 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | [#2] jquery.html Cycles:180 Average:21415.21 Median:47789.14 stddev:63636.68 (133.2%) stddev-sans-first:63795.52 18:54:26 INFO - PROCESS | 16033 | Values: 337.9 340.0 340.0 341.2 342.9 13573.5 14121.9 14595.3 14848.5 15368.7 13419.4 13500.7 14462.6 14482.1 14485.1 4350.1 4370.4 4552.6 4556.5 4559.3 4438.1 4520.4 4528.8 4547.3 4549.9 4317.3 4404.1 5205.5 5412.4 5414.5 5044.7 5195.6 5230.0 5242.7 5244.3 5020.9 5027.2 5030.8 5035.3 5053.1 16904.7 17491.0 17511.4 18208.0 18276.3 1694.6 1706.9 1739.8 1774.5 1802.1 8349.7 8660.6 8725.9 9178.4 11495.4 1665.4 1707.3 1714.6 1753.7 1824.6 47626.8 47951.5 49050.0 49932.0 51338.0 9640.8 9694.9 9710.0 9719.0 9783.5 12212.6 12227.9 12334.9 12355.3 12368.3 6525.4 6556.2 6598.2 6622.4 6637.0 6122.2 6173.3 6175.3 6197.4 6225.9 4163.8 4186.7 4196.2 4204.5 4213.0 1602.1 1675.2 1714.8 1730.9 1743.4 782.9 847.5 856.6 873.9 941.7 13681.3 13893.4 14064.6 14237.6 14389.3 786.0 804.5 808.2 822.5 824.7 7878.1 7928.8 7983.8 8423.5 8442.3 312039.0 319647.0 425843.0 432428.0 437455.0 38800.2 44192.6 61401.4 62627.7 63860.7 1011.6 1030.6 1034.1 1047.3 1059.7 12910.4 13350.5 13547.2 13703.0 13911.9 26294.2 26692.0 27255.0 27470.0 28270.0 33551.2 34331.3 35432.0 35822.0 35867.1 6534.8 6622.4 6748.9 6757.4 6892.8 8625.4 8795.5 9517.4 9771.9 9774.4 7970.4 8562.5 8665.2 8675.2 8713.3 8455.0 8537.6 8701.4 8930.3 9142.5 6295.0 6565.5 6842.8 7026.4 7162.9 8267.4 8680.0 8688.3 8814.4 8826.9 8486.4 8586.7 8680.6 8707.7 8751.3 18:54:26 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | [#3] mootools.html Cycles:180 Average:4818.25 Median:6102.36 stddev:2483.82 (40.7%) stddev-sans-first:2476.99 18:54:26 INFO - PROCESS | 16033 | Values: 1335.0 1340.7 1441.4 1668.9 1694.3 6100.0 6146.3 6550.7 6609.3 6639.4 6552.9 6686.4 6728.7 6762.8 6767.8 2051.8 2082.0 2083.9 2086.2 2087.5 2025.9 2048.2 2065.4 2099.5 2105.0 2058.9 2060.5 2065.5 2077.2 2078.1 2015.9 2035.3 2038.0 2039.9 2041.5 2047.3 2057.1 2087.8 2093.0 2094.3 7065.5 7066.6 7070.0 7070.3 7103.9 3975.1 4096.4 4098.0 4099.3 4130.3 2650.7 2651.6 2687.4 2694.2 2714.7 777.7 779.1 784.3 811.1 813.6 9400.7 9437.8 9441.1 9450.7 9472.4 3736.0 3780.6 3812.4 3818.4 3843.0 8058.1 8078.6 8081.2 8102.1 8119.4 4140.4 4154.1 4182.5 4190.4 4210.4 3218.2 3275.1 3632.5 3787.5 3812.2 3259.5 3290.3 3298.3 3320.8 3324.7 1003.0 1010.6 1012.3 1016.0 1020.2 869.5 881.1 979.9 1011.6 1019.8 6296.1 6325.6 6507.5 6664.4 6681.3 1006.5 1006.6 1028.2 1040.8 1049.1 5008.5 5128.7 5129.6 5140.6 5143.6 8038.7 8409.8 8673.0 8768.0 8800.0 7901.3 7969.3 7976.6 8011.2 8016.4 6633.8 6757.7 6778.8 6789.7 6818.2 6135.2 6200.3 6304.7 6323.1 6338.8 7173.6 7338.2 7374.6 7397.7 7439.0 7368.5 7464.4 7524.6 7617.7 7680.6 5258.2 5470.6 6222.2 6330.4 6337.8 6264.2 6347.3 6347.3 6393.3 6414.5 5985.2 6037.4 6113.8 6193.9 6206.6 6127.3 6134.0 6137.4 6181.5 6251.2 6180.0 6207.0 6221.0 6222.0 6236.9 5680.2 5710.7 5724.6 5725.8 5732.3 5996.3 6079.2 6086.0 6100.9 6103.8 18:54:26 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | [#4] prototype.html Cycles:180 Average:4782.67 Median:5485.36 stddev:1417.84 (25.8%) stddev-sans-first:1381.28 18:54:26 INFO - PROCESS | 16033 | Values: 297.8 309.4 310.4 313.2 313.9 5409.5 5463.5 5521.4 5563.2 5604.8 5407.3 5444.4 5484.9 5485.8 5487.3 4138.8 4193.1 4203.2 4223.3 4228.7 4196.6 4205.0 4218.7 4221.2 4224.4 4178.7 4183.2 4183.2 4184.8 4214.8 4214.0 4218.6 4226.0 4233.4 4233.9 3553.6 3680.3 3703.9 3704.8 3707.4 5176.7 5269.6 5288.7 5293.9 5321.6 4813.5 4814.0 4820.8 4823.4 4826.9 5772.5 5784.5 5798.6 5798.6 5807.9 3880.8 3936.3 3975.7 3977.8 3993.5 6014.5 6046.6 6048.8 6051.1 6092.0 4060.1 4067.2 4070.3 4070.8 4087.5 4191.6 4194.5 4200.8 4200.9 4218.6 4586.3 4764.5 4766.5 4776.4 4781.4 5638.3 5723.9 5734.8 5805.2 5821.4 1441.9 1468.9 1469.4 1470.3 1473.5 973.2 973.4 989.9 993.6 1003.3 5058.4 5063.5 5100.1 5100.7 5109.2 5939.7 5985.8 5985.9 5990.8 5991.5 5043.3 5055.8 5069.2 5069.6 5099.9 3175.3 3221.1 3251.8 3261.6 3264.4 5626.8 5633.5 5643.0 5643.1 5663.7 6136.4 6150.0 6165.4 6171.4 6175.5 5511.8 5647.3 5655.2 5672.8 5677.2 5976.0 5986.1 5989.1 5995.2 6001.3 5860.8 5861.6 5866.3 5882.4 5890.4 5631.3 5652.2 5655.2 5658.0 5673.9 4066.7 4101.9 4146.9 4150.9 4159.3 5902.6 5962.9 5969.9 5972.5 6055.7 5845.5 5860.9 5865.6 5874.0 5874.3 5811.4 5817.7 5820.7 5828.7 5832.2 5587.4 5651.1 5707.1 5710.3 5712.0 5849.4 5851.8 5859.3 5871.2 5873.1 5630.9 5675.1 5684.4 5685.2 5685.6 18:54:26 INFO - PROCESS | 16033 | 18:54:26 INFO - PROCESS | 16033 | [#5] yui.html Cycles:180 Average:11742.13 Median:552.88 stddev:13316.31 (2408.6%) stddev-sans-first:13327.83 18:54:26 INFO - PROCESS | 16033 | Values: 697.3 721.7 767.5 769.0 770.6 11541.1 11660.7 11705.0 11725.5 11762.7 11509.1 11570.7 11592.7 11597.3 11619.1 589.0 599.8 757.7 761.8 769.4 766.0 770.9 773.1 775.6 776.5 798.9 799.8 802.4 802.4 802.5 791.3 794.8 795.7 796.1 797.2 593.3 594.1 594.3 594.8 594.8 11523.7 11537.3 11570.4 11599.9 11650.5 11957.8 12115.8 12201.8 12398.0 12414.1 9252.4 9508.1 9584.2 9766.8 9813.0 3191.5 3268.7 3281.9 3295.0 3331.8 36127.5 36339.5 36346.3 36362.6 36614.5 9106.8 9208.2 9409.7 9414.9 9426.3 15953.8 15976.2 15978.2 15994.7 15997.2 6292.7 6296.2 6323.8 6379.2 6562.0 3608.9 3661.1 3706.4 3738.9 3768.8 2558.5 2568.7 2570.8 2580.9 2596.9 465.6 469.7 474.2 474.5 475.4 470.9 505.5 575.8 586.9 598.0 8193.5 8450.0 8497.2 8499.0 8629.9 452.3 479.5 530.0 582.0 624.2 3462.6 3540.1 3623.6 3627.9 3705.2 45538.0 50445.5 50539.5 50609.0 50778.0 43451.6 43830.3 44219.6 44442.8 44494.1 38624.6 38894.4 39320.6 39403.8 40130.0 7207.0 7240.8 7290.9 7330.0 7512.5 27740.4 28357.4 28368.6 28728.7 28841.7 36521.8 38084.2 38157.8 38504.8 38757.2 8624.6 8627.4 8743.1 8781.1 9021.9 10056.9 10236.4 10274.5 10361.4 10685.7 9138.3 9179.5 9252.6 9430.3 9554.3 9324.8 9367.3 9477.2 9588.9 9664.7 9572.7 9588.7 9695.3 9868.1 10087.3 7598.0 7792.8 7801.6 7857.9 7897.6 7669.9 7842.0 8171.2 9168.3 9187.3 18:54:26 INFO - PROCESS | 16033 | -------- Summary: end -------- 18:54:26 INFO - PROCESS | 16033 | 18:54:27 INFO - TEST-INFO | 16033: exit 0 18:54:27 INFO - TEST-OK | dromaeo_css | took 1114061ms 18:54:27 INFO - TEST-START | kraken 18:54:27 INFO - operating with platform_type : linux_ 18:54:27 INFO - Initialising browser for kraken test... 18:54:27 INFO - TEST-INFO | started process 16271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHEBldS/profile http://localhost:38081/getInfo.html) 18:54:30 INFO - PROCESS | 16271 | 18:54:30 INFO - PROCESS | 16271 | (process:16344): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:54:31 INFO - PROCESS | 16271 | __metrics Screen width/height:1600/1200 18:54:31 INFO - PROCESS | 16271 | colorDepth:24 18:54:31 INFO - PROCESS | 16271 | Browser inner width/height: 1024/697 18:54:31 INFO - PROCESS | 16271 | __metrics 18:54:31 INFO - PROCESS | 16271 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:54:32 INFO - TEST-INFO | 16271: exit 0 18:54:32 INFO - Browser initialized. 18:54:32 INFO - Running cycle 1/1 for kraken test... 18:54:32 INFO - TEST-INFO | started process 16393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHEBldS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:34 INFO - PROCESS | 16393 | 18:54:34 INFO - PROCESS | 16393 | (process:16453): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:54:44 INFO - PROCESS | 16393 | RSS: Main: 150122496 18:54:44 INFO - PROCESS | 16393 | 18:54:47 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38081/tests/kraken/driver.html?testName=audio-beat-detection) 18:54:48 INFO - PROCESS | 16393 | RSS: Main: 149880832 18:54:48 INFO - PROCESS | 16393 | 18:54:50 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38081/tests/kraken/driver.html?testName=audio-dft) 18:54:51 INFO - PROCESS | 16393 | RSS: Main: 152997888 18:54:51 INFO - PROCESS | 16393 | 18:54:54 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38081/tests/kraken/driver.html?testName=audio-fft) 18:54:54 INFO - PROCESS | 16393 | RSS: Main: 148455424 18:54:54 INFO - PROCESS | 16393 | 18:54:57 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38081/tests/kraken/driver.html?testName=audio-oscillator) 18:54:57 INFO - PROCESS | 16393 | RSS: Main: 147611648 18:54:57 INFO - PROCESS | 16393 | 18:54:59 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:55:00 INFO - PROCESS | 16393 | RSS: Main: 149655552 18:55:00 INFO - PROCESS | 16393 | 18:55:03 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38081/tests/kraken/driver.html?testName=imaging-darkroom) 18:55:04 INFO - PROCESS | 16393 | RSS: Main: 148967424 18:55:04 INFO - PROCESS | 16393 | 18:55:07 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38081/tests/kraken/driver.html?testName=imaging-desaturate) 18:55:08 INFO - PROCESS | 16393 | RSS: Main: 146833408 18:55:08 INFO - PROCESS | 16393 | 18:55:11 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38081/tests/kraken/driver.html?testName=json-parse-financial) 18:55:11 INFO - PROCESS | 16393 | RSS: Main: 147460096 18:55:11 INFO - PROCESS | 16393 | 18:55:13 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:55:14 INFO - PROCESS | 16393 | RSS: Main: 148410368 18:55:14 INFO - PROCESS | 16393 | 18:55:16 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:55:16 INFO - PROCESS | 16393 | RSS: Main: 147542016 18:55:16 INFO - PROCESS | 16393 | 18:55:18 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:55:19 INFO - PROCESS | 16393 | RSS: Main: 147546112 18:55:19 INFO - PROCESS | 16393 | 18:55:22 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:55:22 INFO - PROCESS | 16393 | RSS: Main: 148082688 18:55:22 INFO - PROCESS | 16393 | 18:55:25 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:55:25 INFO - PROCESS | 16393 | RSS: Main: 147980288 18:55:25 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | Cycle 1(1): loaded http://localhost:38081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38081/tests/kraken/driver.html?testName=ai-astar) 18:55:27 INFO - PROCESS | 16393 | RSS: Main: 148320256 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | __start_tp_report 18:55:27 INFO - PROCESS | 16393 | _x_x_mozilla_page_load 18:55:27 INFO - PROCESS | 16393 | _x_x_mozilla_page_load_details 18:55:27 INFO - PROCESS | 16393 | |i|pagename|runs| 18:55:27 INFO - PROCESS | 16393 | |0;ai-astar;117;110;115;114;116;124;115;115;115;118 18:55:27 INFO - PROCESS | 16393 | |1;audio-beat-detection;158;133;155;170;135;160;154;139;168;132 18:55:27 INFO - PROCESS | 16393 | |2;audio-dft;162;163;162;164;163;165;171;163;168;164 18:55:27 INFO - PROCESS | 16393 | |3;audio-fft;72;73;75;76;145;74;76;72;73;146 18:55:27 INFO - PROCESS | 16393 | |4;audio-oscillator;98;98;134;97;97;96;142;97;98;132 18:55:27 INFO - PROCESS | 16393 | |5;imaging-gaussian-blur;110;110;110;110;111;109;110;111;109;110 18:55:27 INFO - PROCESS | 16393 | |6;imaging-darkroom;148;150;148;148;149;150;147;148;148;148 18:55:27 INFO - PROCESS | 16393 | |7;imaging-desaturate;95;97;96;96;96;97;96;97;96;96 18:55:27 INFO - PROCESS | 16393 | |8;json-parse-financial;71;71;76;73;73;83;73;78;70;70 18:55:27 INFO - PROCESS | 16393 | |9;json-stringify-tinderbox;67;67;67;67;67;68;67;66;68;68 18:55:27 INFO - PROCESS | 16393 | |10;stanford-crypto-aes;82;86;86;91;86;88;86;86;86;83 18:55:27 INFO - PROCESS | 16393 | |11;stanford-crypto-ccm;128;125;122;131;126;125;134;129;130;145 18:55:27 INFO - PROCESS | 16393 | |12;stanford-crypto-pbkdf2;140;158;151;154;150;137;156;151;151;140 18:55:27 INFO - PROCESS | 16393 | |13;stanford-crypto-sha256-iterative;72;77;73;72;73;73;73;70;73;72 18:55:27 INFO - PROCESS | 16393 | __end_tp_report 18:55:27 INFO - PROCESS | 16393 | __start_cc_report 18:55:27 INFO - PROCESS | 16393 | _x_x_mozilla_cycle_collect,792 18:55:27 INFO - PROCESS | 16393 | __end_cc_report 18:55:27 INFO - PROCESS | 16393 | __startTimestamp1452740127948__endTimestamp 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | ------- Summary: start ------- 18:55:27 INFO - PROCESS | 16393 | Number of tests: 14 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.50 stddev:3.54 (3.1%) stddev-sans-first:3.73 18:55:27 INFO - PROCESS | 16393 | Values: 117.0 110.0 115.0 114.0 116.0 124.0 115.0 115.0 115.0 118.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.50 stddev:14.48 (9.3%) stddev-sans-first:15.09 18:55:27 INFO - PROCESS | 16393 | Values: 158.0 133.0 155.0 170.0 135.0 160.0 154.0 139.0 168.0 132.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:2.91 18:55:27 INFO - PROCESS | 16393 | Values: 162.0 163.0 162.0 164.0 163.0 165.0 171.0 163.0 168.0 164.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#3] audio-fft Cycles:10 Average:88.20 Median:73.50 stddev:30.24 (41.1%) stddev-sans-first:31.50 18:55:27 INFO - PROCESS | 16393 | Values: 72.0 73.0 75.0 76.0 145.0 74.0 76.0 72.0 73.0 146.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:97.00 stddev:18.88 (19.5%) stddev-sans-first:19.61 18:55:27 INFO - PROCESS | 16393 | Values: 98.0 98.0 134.0 97.0 97.0 96.0 142.0 97.0 98.0 132.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 18:55:27 INFO - PROCESS | 16393 | Values: 110.0 110.0 110.0 110.0 111.0 109.0 110.0 111.0 109.0 110.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 18:55:27 INFO - PROCESS | 16393 | Values: 148.0 150.0 148.0 148.0 149.0 150.0 147.0 148.0 148.0 148.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 18:55:27 INFO - PROCESS | 16393 | Values: 95.0 97.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#8] json-parse-financial Cycles:10 Average:73.80 Median:73.00 stddev:4.13 (5.7%) stddev-sans-first:4.26 18:55:27 INFO - PROCESS | 16393 | Values: 71.0 71.0 76.0 73.0 73.0 83.0 73.0 78.0 70.0 70.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 18:55:27 INFO - PROCESS | 16393 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 67.0 66.0 68.0 68.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:2.45 (2.8%) stddev-sans-first:2.13 18:55:27 INFO - PROCESS | 16393 | Values: 82.0 86.0 86.0 91.0 86.0 88.0 86.0 86.0 86.0 83.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:129.50 stddev:6.45 (5.0%) stddev-sans-first:6.82 18:55:27 INFO - PROCESS | 16393 | Values: 128.0 125.0 122.0 131.0 126.0 125.0 134.0 129.0 130.0 145.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:151.00 stddev:7.25 (4.8%) stddev-sans-first:6.96 18:55:27 INFO - PROCESS | 16393 | Values: 140.0 158.0 151.0 154.0 150.0 137.0 156.0 151.0 151.0 140.0 18:55:27 INFO - PROCESS | 16393 | 18:55:27 INFO - PROCESS | 16393 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:1.75 (2.4%) stddev-sans-first:1.83 18:55:27 INFO - PROCESS | 16393 | Values: 72.0 77.0 73.0 72.0 73.0 73.0 73.0 70.0 73.0 72.0 18:55:27 INFO - PROCESS | 16393 | -------- Summary: end -------- 18:55:27 INFO - PROCESS | 16393 | 18:55:28 INFO - TEST-INFO | 16393: exit 0 18:55:28 INFO - TEST-OK | kraken | took 61703ms 18:55:28 INFO - TEST-START | v8_7 18:55:28 INFO - operating with platform_type : linux_ 18:55:28 INFO - Initialising browser for v8_7 test... 18:55:28 INFO - TEST-INFO | started process 16681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_EuAl/profile http://localhost:38081/getInfo.html) 18:55:32 INFO - PROCESS | 16681 | 18:55:32 INFO - PROCESS | 16681 | (process:16753): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:55:33 INFO - PROCESS | 16681 | __metrics Screen width/height:1600/1200 18:55:33 INFO - PROCESS | 16681 | colorDepth:24 18:55:33 INFO - PROCESS | 16681 | Browser inner width/height: 1024/697 18:55:33 INFO - PROCESS | 16681 | __metrics 18:55:33 INFO - PROCESS | 16681 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:55:34 INFO - TEST-INFO | 16681: exit 0 18:55:34 INFO - Browser initialized. 18:55:34 INFO - Running cycle 1/1 for v8_7 test... 18:55:34 INFO - TEST-INFO | started process 16802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_EuAl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:55:36 INFO - PROCESS | 16802 | 18:55:36 INFO - PROCESS | 16802 | (process:16857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:55:46 INFO - PROCESS | 16802 | RSS: Main: 150618112 18:55:46 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | Cycle 1(1): loaded http://localhost:38081/tests/v8_7/run.html (next: http://localhost:38081/tests/v8_7/run.html) 18:56:09 INFO - PROCESS | 16802 | RSS: Main: 146059264 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | __start_tp_report 18:56:09 INFO - PROCESS | 16802 | _x_x_mozilla_page_load 18:56:09 INFO - PROCESS | 16802 | _x_x_mozilla_page_load_details 18:56:09 INFO - PROCESS | 16802 | |i|pagename|runs| 18:56:09 INFO - PROCESS | 16802 | |0;Richards;167.0843776106934 18:56:09 INFO - PROCESS | 16802 | |1;DeltaBlue;187.6172607879925 18:56:09 INFO - PROCESS | 16802 | |2;Encrypt;279.4076557697681 18:56:09 INFO - PROCESS | 16802 | |3;Decrypt;5170.103092783505 18:56:09 INFO - PROCESS | 16802 | |4;RayTrace;1086.9565217391305 18:56:09 INFO - PROCESS | 16802 | |5;Earley;703.7297677691766 18:56:09 INFO - PROCESS | 16802 | |6;Boyer;12292.682926829268 18:56:09 INFO - PROCESS | 16802 | |7;RegExp;43574.46808510638 18:56:09 INFO - PROCESS | 16802 | |8;Splay;638.5696040868455 18:56:09 INFO - PROCESS | 16802 | |9;NavierStokes;4826.923076923077 18:56:09 INFO - PROCESS | 16802 | __end_tp_report 18:56:09 INFO - PROCESS | 16802 | __startTimestamp1452740169482__endTimestamp 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | ------- Summary: start ------- 18:56:09 INFO - PROCESS | 16802 | Number of tests: 10 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 167.1 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#1] DeltaBlue Cycles:1 Average:187.62 Median:187.62 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 187.6 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 279.4 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 5170.1 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#4] RayTrace Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 1087.0 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#5] Earley Cycles:1 Average:703.73 Median:703.73 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 703.7 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 12292.7 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#7] RegExp Cycles:1 Average:43574.47 Median:43574.47 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 43574.5 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#8] Splay Cycles:1 Average:638.57 Median:638.57 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 638.6 18:56:09 INFO - PROCESS | 16802 | 18:56:09 INFO - PROCESS | 16802 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 18:56:09 INFO - PROCESS | 16802 | Values: 4826.9 18:56:09 INFO - PROCESS | 16802 | -------- Summary: end -------- 18:56:09 INFO - PROCESS | 16802 | 18:56:10 INFO - TEST-INFO | 16802: exit 0 18:56:10 INFO - TEST-OK | v8_7 | took 41460ms 18:56:10 INFO - SUITE-END | took 1217s 18:56:10 INFO - Completed test suite (00:20:17) 18:56:10 INFO - Working with test: dromaeo_css 18:56:10 INFO - Generating results file: dromaeo_css 18:56:10 INFO - Working with test: kraken 18:56:10 INFO - Generating results file: kraken 18:56:10 INFO - javascript benchmark 18:56:10 INFO - Working with test: v8_7 18:56:10 INFO - Generating results file: v8_7 18:56:10 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:56:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 18:56:10 INFO - process_Request line: dromaeo_css 6043.85 graph.html#tests=[[72,94,43]] 18:56:10 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:56:10 INFO - process_Request line: kraken 1560.60 graph.html#tests=[[232,94,43]] 18:56:10 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:56:10 INFO - process_Request line: v8_7 20159.09 graph.html#tests=[[230,94,43]] 18:56:10 INFO - RETURN: dromaeo_css: 6043.85 18:56:10 INFO - RETURN: kraken: 1560.60 18:56:10 INFO - RETURN: v8_7: 20159.09 18:56:10 INFO - javascript benchmark 18:56:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2624.6325514427995, 2632.710401855796, 2650.2844232057346, 2665.746754058364, 2669.919902402928, 4363.367311739804, 4419.801108950093, 4438.13456376006, 4453.977730111349, 4500.16746901823, 4480.350349199364, 4556.179887620227, 4562.543745625436, 4599.425071866017, 4620.237660785966, 4227.809748561307, 4231.597998190167, 4295.742255464666, 4311.762853043081, 4325.52419233884, 4156.981539522822, 4159.334506478964, 4210.578942105795, 4232.3016702244095, 4256.148770245948, 4110.260153172428, 4167.729097608676, 4201.138766552849, 4204.873853784391, 4277.572242775728, 4182.790860456965, 4204.789760511962, 4204.810783514749, 4221.155768846243, 4249.660027197817, 4209.0, 4215.178040282146, 4227.175700738358, 4228.069824638575, 4229.577042295746, 4339.544347843463, 4418.867433976986, 4434.711743736679, 4448.154850578379, 4464.6874718769695, 4768.260919557474, 4872.537108974641, 4906.067847109038, 4933.407991041062, 4963.751812409365, 4936.456989731127, 4943.678660887031, 4955.98402327522, 4960.305557221992, 5003.0, 4385.934210986838, 4474.284114541722, 4563.133004729091, 4590.563896429834, 4651.395318608593, 4985.476524964826, 5032.6980381177245, 5033.219850923113, 5051.595872330205, 5071.18860982241, 4740.075685241345, 4742.075295317449, 4747.620190384761, 4747.8100875965265, 4793.376861008116, 4758.547937945889, 4830.855074347775, 4831.0, 4839.540243676845, 4887.462379138292, 4757.976210118927, 4765.309030190603, 4787.257975013878, 4793.664443488992, 4811.374521312207, 4714.882127946828, 4728.621710263171, 4733.763311834395, 4754.334393184957, 4778.689385189951, 3981.323175060189, 3981.601839816053, 3991.560928297885, 3993.7004724645767, 4034.838606455709, 3528.5060091587197, 3580.820958952042, 3607.9278414432088, 3614.945775813365, 3621.9818900905852, 4178.1643671265265, 4202.327627579633, 4214.241436541452, 4220.873373798791, 4242.851500197478, 4773.37946067016, 4783.425988881357, 4827.08285425768, 4845.878853028632, 4888.682235654742, 4276.2516559601945, 4302.419173411612, 4310.181065597589, 4318.546552611993, 4333.306670932636, 4199.685023623179, 4244.957550424518, 4256.616904478612, 4269.402283680287, 4291.163223171452, 4444.7110937789585, 4516.006478574774, 4530.501644819067, 4559.498455169863, 4592.3570700101345, 4882.352649605762, 4883.755812209304, 4917.213245880642, 4921.261810728276, 4928.112939670894, 4639.791209395517, 4656.813727451, 4660.580547750718, 4662.0675864827845, 4692.0146769178855, 4625.098105869323, 4697.741624210565, 4797.2564252540915, 4819.975900120477, 4855.077535268288, 4893.143699852582, 4901.068796928572, 4903.509649035068, 4919.2129259318335, 4963.404391473046, 4697.849026988273, 4722.220833562424, 4746.572808447257, 4757.143714131351, 4803.903921921472, 4618.076384723136, 4684.039771846695, 4700.9529904701885, 4741.383620129499, 4763.261694437368, 4644.419447569054, 4653.418322709661, 4659.953400466087, 4682.789274482589, 4733.5266473352385, 4580.083983203306, 4797.160496912957, 4809.350737650372, 4818.68678535894, 4851.708897466164, 4604.815807367668, 4618.930716039329, 4626.676132670681, 4626.982063945927, 4683.718976861399], "unit": "score", "name": "dojo.html", "value": 4462.700571413246}, {"lowerIsBetter": false, "replicates": [454.8862784303924, 471.6227018385289, 473.621103117506, 476.99830356251874, 498.88026873550314, 31554.36891262176, 32140.196495087635, 32164.839175804118, 32236.355272894558, 32301.0, 34917.301653966904, 35668.10829729258, 35723.4641480378, 35757.46363804545, 35786.2842743145, 7614.657340419667, 7812.648430820626, 7813.726519571816, 7815.452918295721, 7822.765317040498, 7327.230640782721, 7414.851702965964, 7417.184109747924, 7439.107307123153, 7453.81365465865, 7568.848623027536, 7622.390208783312, 7650.655720492591, 7668.0, 7686.730964416247, 7555.7733268001775, 7589.658465369016, 7600.201978792203, 7604.847903041964, 7604.885926711104, 7681.116671582784, 7848.45060845741, 7879.960600196962, 7883.408744344197, 7885.29032387088, 35251.82374088113, 35777.46333804995, 35892.46161307582, 35901.0, 35923.4611480828, 2381.0594365591987, 2831.830090194595, 2870.7559857412143, 3013.0, 3559.1458050068054, 24862.50274994508, 25781.484370312675, 26087.217383478524, 26150.0, 26840.0, 3217.6460589335156, 3272.936295703882, 3328.517364982088, 3394.6435624259593, 3432.6052503962114, 177285.0, 178675.0, 179591.10204449156, 179671.0, 179777.0, 45285.54714452814, 46441.071178576916, 49018.26472602914, 52455.0, 53271.73364133154, 53379.0, 53579.73210134002, 53768.19347709788, 54003.18995215075, 54027.459725402245, 13716.108452950526, 13738.86261137376, 13842.653933651538, 13844.10013349129, 13845.653858653613, 10289.74275643115, 10305.278630495794, 10326.896731032744, 10329.276950613536, 10340.844887326695, 18207.81792182088, 18310.63378732418, 18459.353922612645, 18471.261149554135, 18479.81520184781, 7156.785296441115, 7483.8503229935095, 7489.588072656056, 7603.581803000778, 7652.196519365498, 822.042320696382, 830.7050996896136, 840.1178762299561, 869.8042940338373, 886.2289807867197, 25991.592396167, 26227.426354418796, 26301.47397052048, 26330.6050409244, 26379.208623741317, 972.0619602084023, 1017.4404077757204, 1032.2413026425572, 1043.1811028342715, 1048.1509976918721, 13714.588562343146, 13793.0, 13823.861761382459, 13935.790963135561, 13941.721165576631, 263969.0, 266219.0, 267611.0, 268944.0, 269038.0, 44861.327080093826, 45878.0, 46082.30876536854, 46174.0, 46299.0, 1206.9818952715716, 1214.2435530512291, 1222.4254600337827, 1233.3709807997807, 1236.0914727675151, 25158.62262066107, 25620.35949101213, 25705.871470642527, 25828.0, 25911.611325829752, 39824.60175398209, 40307.1938561233, 40310.79844600758, 40311.0, 40429.1914161721, 249387.0, 250674.0, 250681.0, 252305.0, 253499.0, 28444.57333140046, 28748.0, 28892.711072889004, 28918.855405722836, 29081.418371632026, 32961.505577415875, 32988.50517242291, 33769.0, 33904.0, 34041.82979085188, 27172.72827271702, 27430.725692742817, 27672.861635691694, 27825.582616261177, 27859.303517412227, 28297.57553636738, 28359.149225523266, 28374.432511349245, 28572.57141142843, 29129.0, 30912.0726378209, 31364.529532056582, 31504.842475787475, 31668.524972124975, 31859.36281274315, 27114.864425678534, 28465.857670711513, 29237.0, 30976.69023309828, 32595.348093037534, 23147.4213144666, 24574.139905103235, 25305.691113647983, 25325.62011569791, 25328.366790830376], "unit": "score", "name": "ext.html", "value": 16065.718381847064}, {"lowerIsBetter": false, "replicates": [337.87498625508556, 339.9762016658835, 340.04786597526925, 341.22031158802145, 342.8851334802841, 13573.457061717532, 14121.858781412182, 14595.270236488159, 14848.480303189377, 15368.692626147471, 13419.396127174276, 13500.729985400287, 14462.638434039154, 14482.131072135679, 14485.130892146452, 4350.108227813299, 4370.366296886949, 4552.567506086916, 4556.476005259405, 4559.293309537027, 4438.068005718803, 4520.389747384094, 4528.75091869947, 4547.340635607835, 4549.909001819961, 4317.287647538153, 4404.053128577355, 5205.531502164805, 5412.377576578685, 5414.512693857552, 5044.747762611892, 5195.584353251731, 5230.0, 5242.685438873642, 5244.344456942901, 5020.874478138039, 5027.195648696227, 5030.8239211627415, 5035.269885866529, 5053.065182941167, 16904.746428803577, 17490.95054296746, 17511.387101451517, 18208.0, 18276.268949242014, 1694.6187107900746, 1706.9487915362558, 1739.7908453624736, 1774.5208793625777, 1802.0809387212616, 8349.707760228424, 8660.566971651393, 8725.869111963326, 9178.357514973955, 11495.367754773484, 1665.3671604790222, 1707.3170731707291, 1714.588498760301, 1753.6755700195376, 1824.6077093424976, 47626.76186619045, 47951.52048479505, 49050.0, 49931.999999999636, 51338.0, 9640.807183856283, 9694.854577181348, 9710.028997100233, 9718.951405242928, 9783.46190959504, 12212.633620991384, 12227.938860305641, 12334.876651233551, 12355.25868447896, 12368.257904525757, 6525.412712855771, 6556.18047744032, 6598.208215014229, 6622.37087476689, 6636.966815165893, 6122.173506576644, 6173.32093469718, 6175.320714721377, 6197.442230199304, 6225.906611400833, 4163.770992595376, 4186.7278626889765, 4196.160767846443, 4204.51648060477, 4212.957870421318, 1602.094816428714, 1675.1791622105081, 1714.8244025797223, 1730.8788384813195, 1743.4246698589436, 782.8786538086606, 847.4660963592897, 856.5545916123706, 873.9388242822941, 941.6845356805546, 13681.31593420325, 13893.374798134108, 14064.578062658136, 14237.572872813833, 14389.28053597316, 785.9764207073797, 804.481109684262, 808.2362167751536, 822.5188264865001, 824.6660102658433, 7878.094019187753, 7928.841423171504, 7983.800404989922, 8423.452475589189, 8442.282405995436, 312039.0, 319647.0, 425843.0, 432428.0, 437455.0, 38800.22399551993, 44192.55807441949, 61401.38598613957, 62627.68686156631, 63860.68069659622, 1011.6256984915628, 1030.577463240083, 1034.131329683055, 1047.3035431438161, 1059.7191744187796, 12910.354482276036, 13350.465981360638, 13547.187168769511, 13703.040787144804, 13911.930440347733, 26294.211173664822, 26692.0, 27255.0, 27470.0, 28270.0, 33551.16122096967, 34331.313373731886, 35432.0, 35822.0, 35867.10332241715, 6534.8366290843105, 6622.37087476689, 6748.865022699617, 6757.358050985148, 6892.827679308058, 8625.353098517511, 8795.516246606498, 9517.381370210915, 9771.902280977383, 9774.364666296668, 7970.362371010421, 8562.48625082472, 8665.220130188314, 8675.219230269306, 8713.25937295337, 8455.0, 8537.624230951105, 8701.390902636755, 8930.285577153942, 9142.497162656118, 6295.0, 6565.507586930904, 6842.794716158523, 7026.437884969088, 7162.89255661176, 8267.379946504156, 8680.0, 8688.348373871859, 8814.427062240933, 8826.867596985921, 8486.448380855225, 8586.656533738831, 8680.609372578123, 8707.738767836974, 8751.343649226206], "unit": "score", "name": "jquery.html", "value": 7218.740178874371}, {"lowerIsBetter": false, "replicates": [1334.9532766353177, 1340.705044890124, 1441.4378392426956, 1668.883178177528, 1694.3053348127262, 6099.969500152504, 6146.262448506174, 6550.705218265178, 6609.339066093395, 6639.3692599203, 6552.934470655292, 6686.431653309474, 6728.730850765975, 6762.830929226772, 6767.76312829051, 2051.846111541633, 2081.9902347361594, 2083.927062552811, 2086.1655337864822, 2087.4781304673834, 2025.8581899267058, 2048.1807277089133, 2065.4423305707523, 2099.4751312171957, 2104.9579008419823, 2058.9176432942663, 2060.453979695382, 2065.5249292662697, 2077.158750705959, 2078.085642317383, 2015.9092840822125, 2035.2571311471354, 2038.042120203502, 2039.8576796993732, 2041.530447996954, 2047.3346162497248, 2057.0537552725764, 2087.8016588424075, 2092.95814083719, 2094.277474271374, 7065.505414620979, 7066.611336376497, 7069.9646501767675, 7070.29297070294, 7103.89344159838, 3975.0857302820223, 4096.446979657768, 4097.959020409788, 4099.262132816092, 4130.339145736698, 2650.681918169832, 2651.615515750225, 2687.4490729400427, 2694.245611228859, 2714.742099500544, 777.7277952716561, 779.1312686354673, 784.329398364396, 811.119934870666, 813.5810057820228, 9400.717978460725, 9437.811243775155, 9441.055894410572, 9450.716478505656, 9472.384295020871, 3735.9912823537493, 3780.584135745066, 3812.4471951566866, 3818.3890577507464, 3843.0392401899526, 8058.11360750317, 8078.596070196584, 8081.151479094728, 8102.108768035511, 8119.3910456715985, 4140.358244472111, 4154.065335299594, 4182.456280683492, 4190.434291370626, 4210.410542524049, 3218.1954511372155, 3275.066606017321, 3632.5096112025067, 3787.5265591801026, 3812.1803812180515, 3259.4947783093658, 3290.341931613687, 3298.290867463507, 3320.833958302075, 3324.700776930088, 1003.0420947994647, 1010.5907107621425, 1012.2964539645023, 1015.9796804064025, 1020.2144348851343, 869.5000374784524, 881.1276835932381, 979.8726165598426, 1011.5801942193907, 1019.7807471393686, 6296.087067375205, 6325.620462772156, 6507.479401647857, 6664.433523150489, 6681.331866813377, 1006.5219020965129, 1006.6225165562914, 1028.1980055556678, 1040.8282633365409, 1049.1134990932803, 5008.499150085036, 5128.692278463304, 5129.563987061141, 5140.640155189176, 5143.6399452037995, 8038.718644847402, 8409.789755256044, 8672.95663521691, 8767.956160219286, 8800.0, 7901.328387087047, 7969.282764551218, 7976.5612891290375, 8011.158828322942, 8016.438849280611, 6633.767818126343, 6757.729690812313, 6778.830529236809, 6789.6605169741315, 6818.2159051708695, 6135.233095863017, 6200.3489633589625, 6304.65324407162, 6323.1463752394675, 6338.841528961812, 7173.569585824867, 7338.156112047183, 7374.557526548424, 7397.741079062207, 7438.962805185939, 7368.484206105735, 7464.440166987389, 7524.623768811647, 7617.65720542588, 7680.577568233801, 5258.158694608845, 5470.617056805985, 6222.160008398808, 6330.39861213184, 6337.7781777637565, 6264.154339164154, 6347.301796802256, 6347.301796802441, 6393.29673735898, 6414.454771344488, 5985.221921150222, 6037.366076561898, 6113.847153821012, 6193.876122477435, 6206.627602343874, 6127.295361033538, 6133.969330153321, 6137.41694539018, 6181.474574661204, 6251.156093927261, 6179.969100154471, 6206.968965155145, 6220.968895155495, 6222.0, 6236.875262494634, 5680.204771331934, 5710.65736055838, 5724.627899186539, 5725.828225153252, 5732.340780810094, 5996.280446346466, 6079.179310792986, 6086.0, 6100.938990610037, 6103.786367477117], "unit": "score", "name": "mootools.html", "value": 3962.3823382584715}, {"lowerIsBetter": false, "replicates": [297.81981900949927, 309.37351862478477, 310.3637543036774, 313.1513598149016, 313.87288148299945, 5409.486098820616, 5463.535599474049, 5521.392646808853, 5563.193336966137, 5604.8038318658855, 5407.270018547495, 5444.373897001846, 5484.945150548493, 5485.780568777254, 5487.314085739283, 4138.7516748995, 4193.077522944947, 4203.180379825935, 4223.3031549794405, 4228.682848786338, 4196.580341965794, 4204.97897510512, 4218.683598730092, 4221.2190744712325, 4224.366345048236, 4178.6657067434535, 4183.184279065584, 4183.184279065584, 4184.790760461965, 4214.7681877496725, 4213.988642725754, 4218.620324170839, 4225.978870105645, 4233.386159006942, 4233.851815186485, 3553.5558055243096, 3680.3191409589044, 3703.925921481582, 3704.7777133372083, 3707.4253490708984, 5176.663516871429, 5269.552088072518, 5288.709120998344, 5293.86765330866, 5321.627486075976, 4813.518648135194, 4813.975930120327, 4820.783064762094, 4823.3729615149805, 4826.879328016793, 5772.451617096411, 5784.4504772046585, 5798.594098413113, 5798.623089499211, 5807.941920580783, 3880.805959702032, 3936.252112098692, 3975.7216994810374, 3977.8209980550946, 3993.5407428145845, 6014.488768454687, 6046.606970546901, 6048.8185354439, 6051.1225872248715, 6092.0, 4060.1067765091634, 4067.247559201557, 4070.2673518766906, 4070.776107314067, 4087.4686290782006, 4191.559886211965, 4194.517630472474, 4200.789960501963, 4200.873973780792, 4218.578142185757, 4586.2661974083985, 4764.523547645277, 4766.45185803637, 4776.426828780569, 4781.42622885256, 5638.2670252866865, 5723.885522289531, 5734.770609175586, 5805.187273781674, 5821.359650438449, 1441.8558144185497, 1468.8898332624883, 1469.4489566412594, 1470.3383477434984, 1473.528470889305, 973.1825266775942, 973.3721749471551, 989.8861630912537, 993.5975929748463, 1003.3327836988321, 5058.392992840809, 5063.468335824759, 5100.056489549445, 5100.69395836251, 5109.233614957711, 5939.70301484924, 5985.790497332572, 5985.850353741104, 5990.760369585255, 5991.5206783457215, 5043.293938848564, 5055.797768089235, 5069.239614057847, 5069.5690866276045, 5099.949000509948, 3175.25381535339, 3221.098092534094, 3251.772375933662, 3261.6249131349723, 3264.4124057669846, 5626.831195064155, 5633.521150702154, 5643.01247281724, 5643.097104463266, 5663.716814159358, 6136.447719705248, 6150.04674275488, 6165.414285642857, 6171.413715697002, 6175.536834737412, 5511.807086751945, 5647.29408823897, 5655.1799989001365, 5672.773089076473, 5677.233573467612, 5975.970120149372, 5986.102084687332, 5989.131575921379, 5995.16067750524, 6001.319630503466, 5860.765569377178, 5861.560382971209, 5866.2960444746905, 5882.411758824083, 5890.381509941394, 5631.324241091095, 5652.152177173457, 5655.179998900054, 5658.0, 5673.914891276717, 4066.6543343816106, 4101.876943691694, 4146.937795933003, 4150.91698166029, 4159.313713237282, 5902.557308201816, 5962.9105563415715, 5969.850753731192, 5972.522198224218, 6055.727492262947, 5845.503132233808, 5860.941390586039, 5865.560082993878, 5874.001419758566, 5874.324452687995, 5811.418858114154, 5817.680027598522, 5820.679862607428, 5828.708564571839, 5832.183494310885, 5587.357453892691, 5651.095824668033, 5707.086866101404, 5710.2576665033275, 5711.971440142773, 5849.415058494286, 5851.834821116215, 5859.296884373903, 5871.178035075008, 5873.148393482836, 5630.85922851932, 5675.0636145035605, 5684.403137670485, 5685.175649530877, 5685.630434021776], "unit": "score", "name": "prototype.html", "value": 4324.202248891822}, {"lowerIsBetter": false, "replicates": [697.3166297028912, 721.6824597177242, 767.5394763142114, 768.9884651730222, 770.5800338815345, 11541.076713862893, 11660.708482287948, 11705.0, 11725.47235374408, 11762.705932351684, 11509.079273658108, 11570.710732231699, 11592.710182245448, 11597.3041617503, 11619.12856535759, 589.0339842658044, 599.7780821096201, 757.6969212315063, 761.8247803005312, 769.3883362726618, 765.9770206893802, 770.8959290495795, 773.0877564473918, 775.6276987046222, 776.5301992294637, 798.932090772285, 799.7760627024443, 802.3781569283793, 802.4342838298985, 802.5265093594778, 791.3036527855479, 794.8370584030289, 795.6658203554521, 796.1004065406054, 797.2466019611469, 593.2791658135343, 594.1266338482424, 594.3195041677299, 594.7769586405099, 594.8156071617813, 11523.711907202303, 11537.307761534335, 11570.363630000347, 11599.94200029003, 11650.533978640844, 11957.760844783143, 12115.757684846341, 12201.755964880742, 12398.0, 12414.131010829245, 9252.398594091363, 9508.144267016001, 9584.185344245678, 9766.804663906682, 9813.018698130201, 3191.4734068878606, 3268.656791036931, 3281.917952051194, 3295.0, 3331.800091994488, 36127.4580881287, 36339.4549081764, 36346.27307453863, 36362.63637363619, 36614.45078323827, 9106.772330691785, 9208.171264586086, 9409.71770846862, 9414.858777118348, 9426.340156189139, 15953.760693589606, 15976.201189940457, 15978.201089945456, 15994.680106397807, 15997.200139992954, 6292.685365731695, 6296.212973378328, 6323.810285691437, 6379.202599675041, 6562.0, 3608.891733248007, 3661.1030297577263, 3706.4440333949583, 3738.8691395801015, 3768.792716400624, 2558.539462896659, 2568.7284794026705, 2570.8200425970376, 2580.9225723228333, 2596.9091081812044, 465.64843543125403, 469.70408642555657, 474.15126922808474, 474.5254745254745, 475.4366076199714, 470.934069230308, 505.54248405193357, 575.7610591604438, 586.8503531599415, 598.0, 8193.549354785544, 8450.0, 8497.192766687278, 8498.957505212558, 8629.870551941725, 452.32377595494944, 479.4749749024812, 529.9920501192486, 581.994180058194, 624.188554878656, 3462.6364231755806, 3540.1149712571855, 3623.61951995042, 3627.945580816237, 3705.2219034002624, 45538.0, 50445.49554504408, 50539.49460505348, 50609.0, 50778.0, 43451.56548434538, 43830.34254486185, 44219.55780442154, 44442.77778611086, 44494.11011779746, 38624.613753862664, 38894.41658375126, 39320.60679393169, 39403.802980985485, 40130.0, 7206.963965180141, 7240.818979525554, 7290.854182916418, 7329.963350183215, 7512.511686740344, 27740.445191096467, 28357.43285134327, 28368.574471382533, 28728.712712872602, 28841.7115828839, 36521.81739091394, 38084.238315232986, 38157.80921095377, 38504.80747596244, 38757.224855502165, 8624.568771561522, 8627.43921645091, 8743.12568743146, 8781.077986811548, 9021.90978090237, 10056.89943100589, 10236.385816851012, 10274.537645805807, 10361.4301213434, 10685.679429617125, 9138.347463944345, 9179.541022948959, 9252.583633736363, 9430.339876208875, 9554.331196816434, 9324.766880828034, 9367.297452691211, 9477.194438472807, 9588.856167157359, 9664.661736839176, 9572.664956726481, 9588.712338629852, 9695.272854536079, 9868.062534059252, 10087.3443226193, 7597.962010189914, 7792.844143116992, 7801.609919503889, 7857.882131768142, 7897.644605992629, 7669.923300767144, 7842.0, 8171.223733745284, 9168.266538677024, 9187.310951678517], "unit": "score", "name": "yui.html", "value": 5495.649575133466}], "name": "dromaeo_css", "value": 6043.852489985519}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 110.0, 115.0, 114.0, 116.0, 124.0, 115.0, 115.0, 115.0, 118.0], "unit": "score", "name": "ai-astar", "value": 115.9}, {"lowerIsBetter": true, "replicates": [158.0, 133.0, 155.0, 170.0, 135.0, 160.0, 154.0, 139.0, 168.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 164.0, 163.0, 165.0, 171.0, 163.0, 168.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 75.0, 76.0, 145.0, 74.0, 76.0, 72.0, 73.0, 146.0], "unit": "score", "name": "audio-fft", "value": 88.2}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 134.0, 97.0, 97.0, 96.0, 142.0, 97.0, 98.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 111.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 148.0, 148.0, 149.0, 150.0, 147.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 76.0, 73.0, 73.0, 83.0, 73.0, 78.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 73.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [82.0, 86.0, 86.0, 91.0, 86.0, 88.0, 86.0, 86.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [128.0, 125.0, 122.0, 131.0, 126.0, 125.0, 134.0, 129.0, 130.0, 145.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.5}, {"lowerIsBetter": true, "replicates": [140.0, 158.0, 151.0, 154.0, 150.0, 137.0, 156.0, 151.0, 151.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [72.0, 77.0, 73.0, 72.0, 73.0, 73.0, 73.0, 70.0, 73.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.8}], "name": "kraken", "value": 1560.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [187.6172607879925], "unit": "score", "name": "DeltaBlue", "value": 352.4089399999998}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1086.9565217391305], "unit": "score", "name": "RayTrace", "value": 680.7898799999998}, {"lowerIsBetter": false, "replicates": [703.7297677691766], "unit": "score", "name": "Earley", "value": 947.0439230000003}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [43574.46808510638], "unit": "score", "name": "RegExp", "value": 20.906394042968756}, {"lowerIsBetter": false, "replicates": [638.5696040868455], "unit": "score", "name": "Splay", "value": 127.61490600000003}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20159.09440709901}]} 18:56:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20159.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1560.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6043.85"}}} 18:56:10 INFO - Return code: 0 18:56:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:56:10 INFO - # TBPL SUCCESS # 18:56:10 INFO - Running post-action listener: _resource_record_post_action 18:56:10 INFO - Running post-run listener: _resource_record_post_run 18:56:11 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 541769728; Read time: 0; Write time: 507640 18:56:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231817216; Read time: 0; Write time: 253524 18:56:11 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 309952512; Read time: 0; Write time: 254116 18:56:11 INFO - Running post-run listener: _upload_blobber_files 18:56:11 INFO - Blob upload gear active. 18:56:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:56:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:56:12 INFO - (blobuploader) - INFO - Open directory for files ... 18:56:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:56:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:56:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:56:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:56:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:56:13 INFO - (blobuploader) - INFO - Done attempting. 18:56:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:56:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:56:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:56:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:56:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:56:14 INFO - (blobuploader) - INFO - Done attempting. 18:56:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:56:14 INFO - Return code: 0 18:56:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:56:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:56:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/398129033a15d8b317fd15f505bfacdbc3bde6c5965f267625e6081dbc43e37d4a41e27c71282b4c2af9874eed2e769b96b5e7b005170f6b3e7ea663505e4f64", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5da9f372c2b0d7de9bc2263116c2ed8c400cf97e89567cf401700a903b3506258ea23886248a086d7a9736ae8eb5d4949c9226d73bf79ba50c4e692f020a37b0"} 18:56:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:56:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:56:14 INFO - Contents: 18:56:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/398129033a15d8b317fd15f505bfacdbc3bde6c5965f267625e6081dbc43e37d4a41e27c71282b4c2af9874eed2e769b96b5e7b005170f6b3e7ea663505e4f64", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5da9f372c2b0d7de9bc2263116c2ed8c400cf97e89567cf401700a903b3506258ea23886248a086d7a9736ae8eb5d4949c9226d73bf79ba50c4e692f020a37b0"} 18:56:14 INFO - Copying logs to upload dir... 18:56:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.403090 ========= master_lag: 12.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-13 18:56:26.851075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 18:56:26.854459) ========= 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=4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/398129033a15d8b317fd15f505bfacdbc3bde6c5965f267625e6081dbc43e37d4a41e27c71282b4c2af9874eed2e769b96b5e7b005170f6b3e7ea663505e4f64", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5da9f372c2b0d7de9bc2263116c2ed8c400cf97e89567cf401700a903b3506258ea23886248a086d7a9736ae8eb5d4949c9226d73bf79ba50c4e692f020a37b0"} build_url:https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009981 build_url: 'https://queue.taskcluster.net/v1/task/P6tX7u8uSV-r6qPnlDFGAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/398129033a15d8b317fd15f505bfacdbc3bde6c5965f267625e6081dbc43e37d4a41e27c71282b4c2af9874eed2e769b96b5e7b005170f6b3e7ea663505e4f64", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5da9f372c2b0d7de9bc2263116c2ed8c400cf97e89567cf401700a903b3506258ea23886248a086d7a9736ae8eb5d4949c9226d73bf79ba50c4e692f020a37b0"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 18:56:27.309863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:56:27.310178) ========= 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=4dd8011cc2821079d74a932a000001ae-1452738063.461344-1408461439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 18:56:27.327941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 18:56:27.328216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 18:56:28.056055) ========= ========= Total master_lag: 13.05 =========