builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1456317316.66 results: success (0) buildid: 20160224015246 builduid: 2831fa2e4e694077aa22397ee236b029 revision: 03725a09cbb51cbda9d9b7e1de0b0873d5bbc321 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.659364) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.659895) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.660227) ========= bash -c pwd in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008466 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.683951) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.684296) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.697796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.698223) ========= rm -rf properties in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.747979) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.748319) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.748728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.749033) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-24 04:35:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-02-24 04:35:16 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169078 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.930787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.931135) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019058 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:16.981543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-24 04:35:16.981953) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 03725a09cbb51cbda9d9b7e1de0b0873d5bbc321 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 03725a09cbb51cbda9d9b7e1de0b0873d5bbc321 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-24 04:35:17,105 truncating revision to first 12 chars 2016-02-24 04:35:17,105 Setting DEBUG logging. 2016-02-24 04:35:17,105 attempt 1/10 2016-02-24 04:35:17,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/03725a09cbb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 04:35:19,221 unpacking tar archive at: mozilla-aurora-03725a09cbb5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.452948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-24 04:35:19.448389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:19.448815) ========= echo 03725a09cbb51cbda9d9b7e1de0b0873d5bbc321 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'03725a09cbb51cbda9d9b7e1de0b0873d5bbc321'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03725a09cbb51cbda9d9b7e1de0b0873d5bbc321 program finished with exit code 0 elapsedTime=0.003754 script_repo_revision: '03725a09cbb51cbda9d9b7e1de0b0873d5bbc321' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:19.498160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:19.498518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:19.508523) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-24 04:35:19.508897) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:35:19 INFO - MultiFileLogger online at 20160224 04:35:19 in /builds/slave/test-pgo 04:35:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:35:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:35:19 INFO - {'append_to_log': False, 04:35:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:35:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:35:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:35:19 INFO - 'branch': 'Mozilla-Aurora', 04:35:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:19 INFO - 'config_files': ('talos/linux_config.py',), 04:35:19 INFO - 'default_actions': ('clobber', 04:35:19 INFO - 'read-buildbot-config', 04:35:19 INFO - 'download-and-extract', 04:35:19 INFO - 'populate-webroot', 04:35:19 INFO - 'create-virtualenv', 04:35:19 INFO - 'install', 04:35:19 INFO - 'run-tests'), 04:35:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:19 INFO - 'download_minidump_stackwalk': True, 04:35:19 INFO - 'download_symbols': 'ondemand', 04:35:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:19 INFO - 'installer_path': 'installer.exe', 04:35:19 INFO - 'log_level': 'info', 04:35:19 INFO - 'log_name': 'talos', 04:35:19 INFO - 'log_to_console': True, 04:35:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:35:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:35:19 INFO - 'opt_config_files': (), 04:35:19 INFO - 'pip_index': False, 04:35:19 INFO - 'sps_profile': False, 04:35:19 INFO - 'sps_profile_interval': 0, 04:35:19 INFO - 'suite': 'dromaeojs-e10s', 04:35:19 INFO - 'system_bits': '32', 04:35:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:19 INFO - 'title': 'talos-linux64-ix-057', 04:35:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:19 INFO - 'use_talos_json': True, 04:35:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:35:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:19 INFO - 'work_dir': 'build'} 04:35:19 INFO - ##### 04:35:19 INFO - ##### Running clobber step. 04:35:19 INFO - ##### 04:35:19 INFO - Running pre-action listener: _resource_record_pre_action 04:35:19 INFO - Running main action method: clobber 04:35:19 INFO - rmtree: /builds/slave/test-pgo/build 04:35:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:35:20 INFO - Running post-action listener: _resource_record_post_action 04:35:20 INFO - ##### 04:35:20 INFO - ##### Running read-buildbot-config step. 04:35:20 INFO - ##### 04:35:20 INFO - Running pre-action listener: _resource_record_pre_action 04:35:20 INFO - Running main action method: read_buildbot_config 04:35:20 INFO - Using buildbot properties: 04:35:20 INFO - { 04:35:20 INFO - "project": "", 04:35:20 INFO - "product": "firefox", 04:35:20 INFO - "script_repo_revision": "production", 04:35:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:35:20 INFO - "repository": "", 04:35:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:35:20 INFO - "buildid": "20160224015246", 04:35:20 INFO - "pgo_build": "True", 04:35:20 INFO - "basedir": "/builds/slave/test-pgo", 04:35:20 INFO - "buildnumber": 161, 04:35:20 INFO - "slavename": "talos-linux64-ix-057", 04:35:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:35:20 INFO - "platform": "ubuntu64_hw", 04:35:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:35:20 INFO - "branch": "mozilla-aurora", 04:35:20 INFO - "repo_path": "releases/mozilla-aurora", 04:35:20 INFO - "revision": "03725a09cbb51cbda9d9b7e1de0b0873d5bbc321", 04:35:20 INFO - "stage_platform": "linux64-pgo", 04:35:20 INFO - "builduid": "2831fa2e4e694077aa22397ee236b029", 04:35:20 INFO - "slavebuilddir": "test" 04:35:20 INFO - } 04:35:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 04:35:20 INFO - Running post-action listener: _resource_record_post_action 04:35:20 INFO - ##### 04:35:20 INFO - ##### Running download-and-extract step. 04:35:20 INFO - ##### 04:35:20 INFO - Running pre-action listener: _resource_record_pre_action 04:35:20 INFO - Running main action method: download_and_extract 04:35:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 04: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')]} 04:35:20 INFO - https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:35:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/test_packages.json 04:35:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/test_packages.json 04:35:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:35:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:35:20 INFO - Downloaded 1448 bytes. 04:35:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:35:20 INFO - Using the following test package requirements: 04:35:20 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:35:20 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:35:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:35:20 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:35:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:35:20 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:35:20 INFO - u'jsshell-linux-x86_64.zip'], 04:35:20 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:35:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:35:20 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:35:20 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:35:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:35:20 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:35:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:35:20 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:35:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:35:20 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 04:35:20 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 04:35:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:35:20 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04: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')]} 04:35:20 INFO - https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:35:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:35:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:35:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:35:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:35:21 INFO - Downloaded 23078959 bytes. 04:35:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:35:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:35:23 INFO - Return code: 0 04:35:23 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04: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')]} 04:35:23 INFO - https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 04:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:35:24 INFO - Downloaded 23078959 bytes. 04:35:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:35:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:35:25 INFO - Return code: 0 04:35:25 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')]} 04:35:25 INFO - https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 04:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:35:26 INFO - Downloaded 10706572 bytes. 04:35:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:35:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:35:26 INFO - Return code: 0 04: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')]} 04:35:26 INFO - https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:35:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:35:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:35:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:35:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:35:27 INFO - Downloaded 59962327 bytes. 04:35:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:35:27 INFO - mkdir: /builds/slave/test-pgo/properties 04:35:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:35:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:35:27 INFO - Contents: 04:35:27 INFO - build_url:https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 04:35:28 INFO - Running post-action listener: _resource_record_post_action 04:35:28 INFO - Running post-action listener: set_extra_try_arguments 04:35:28 INFO - ##### 04:35:28 INFO - ##### Running populate-webroot step. 04:35:28 INFO - ##### 04:35:28 INFO - Running pre-action listener: _resource_record_pre_action 04:35:28 INFO - Running main action method: populate_webroot 04:35:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:35:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:35:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:35:28 INFO - '--tppagecycles', 04:35:28 INFO - '7'], 04:35:28 INFO - 'tests': ['tsvgm']}}, 04:35:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:35:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:35:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:35:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:35:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:28 INFO - 'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:28 INFO - 'tests': ['damp', 'tps']}, 04:35:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:28 INFO - 'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['damp', 'tps']}, 04:35:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:35:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:35:28 INFO - 'other': {'tests': ['a11yr', 04:35:28 INFO - 'ts_paint', 04:35:28 INFO - 'tpaint', 04:35:28 INFO - 'sessionrestore', 04:35:28 INFO - 'sessionrestore_no_auto_restore']}, 04:35:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['a11yr', 04:35:28 INFO - 'ts_paint', 04:35:28 INFO - 'tpaint', 04:35:28 INFO - 'sessionrestore', 04:35:28 INFO - 'sessionrestore_no_auto_restore']}, 04:35:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['a11yr', 04:35:28 INFO - 'ts_paint', 04:35:28 INFO - 'tpaint', 04:35:28 INFO - 'sessionrestore', 04:35:28 INFO - 'sessionrestore_no_auto_restore']}, 04:35:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['a11yr', 04:35:28 INFO - 'ts_paint', 04:35:28 INFO - 'tpaint', 04:35:28 INFO - 'sessionrestore', 04:35:28 INFO - 'sessionrestore_no_auto_restore']}, 04:35:28 INFO - 'other_l64': {'tests': ['a11yr', 04:35:28 INFO - 'ts_paint', 04:35:28 INFO - 'tpaint', 04:35:28 INFO - 'sessionrestore', 04:35:28 INFO - 'sessionrestore_no_auto_restore']}, 04:35:28 INFO - 'other_nol64': {'tests': ['a11yr', 04:35:28 INFO - 'ts_paint', 04:35:28 INFO - 'tpaint', 04:35:28 INFO - 'sessionrestore', 04:35:28 INFO - 'sessionrestore_no_auto_restore']}, 04:35:28 INFO - 'svgr': {'tests': ['tsvgx', 04:35:28 INFO - 'tsvgr_opacity', 04:35:28 INFO - 'tart', 04:35:28 INFO - 'tscrollx', 04:35:28 INFO - 'cart']}, 04:35:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['tsvgx', 04:35:28 INFO - 'tsvgr_opacity', 04:35:28 INFO - 'tart', 04:35:28 INFO - 'tscrollx', 04:35:28 INFO - 'cart']}, 04:35:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:28 INFO - 'tests': ['tp5o']}, 04:35:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:28 INFO - 'talos_options': ['--e10s'], 04:35:28 INFO - 'tests': ['tp5o']}, 04:35:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:28 INFO - 'talos_options': ['--xperf_path', 04:35:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:28 INFO - 'tests': ['tp5n']}, 04:35:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:28 INFO - 'talos_options': ['--e10s', 04:35:28 INFO - '--xperf_path', 04:35:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:28 INFO - 'tests': ['tp5n']}}, 04:35:28 INFO - 'talos.zip': {'path': '', 04:35:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:35:28 INFO - Running post-action listener: _resource_record_post_action 04:35:28 INFO - ##### 04:35:28 INFO - ##### Running create-virtualenv step. 04:35:28 INFO - ##### 04:35:28 INFO - Running pre-action listener: _resource_record_pre_action 04:35:28 INFO - Running main action method: create_virtualenv 04:35:28 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:35:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:35:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:35:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:35:28 INFO - Using real prefix '/usr' 04:35:28 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:35:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:35:31 INFO - Installing pip.................done. 04:35:31 INFO - Return code: 0 04:35:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 04:35:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:35:31 INFO - Using env: {'DISPLAY': ':0', 04:35:31 INFO - 'HOME': '/home/cltbld', 04:35:31 INFO - 'LANG': 'en_US.UTF-8', 04:35:31 INFO - 'LANGUAGE': 'en_US:en', 04:35:31 INFO - 'LOGNAME': 'cltbld', 04:35:31 INFO - 'MAIL': '/var/mail/cltbld', 04:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:31 INFO - 'MOZ_NO_REMOTE': '1', 04:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:31 INFO - 'NO_EM_RESTART': '1', 04:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:31 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:31 INFO - 'SHELL': '/bin/bash', 04:35:31 INFO - 'SHLVL': '1', 04:35:31 INFO - 'TERM': 'linux', 04:35:31 INFO - 'TMOUT': '86400', 04:35:31 INFO - 'USER': 'cltbld', 04:35:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:31 INFO - '_': '/tools/buildbot/bin/python'} 04:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:31 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 04:35:31 INFO - Cleaning up... 04:35:31 INFO - Return code: 0 04:35:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 04:35:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:35:31 INFO - Using env: {'DISPLAY': ':0', 04:35:31 INFO - 'HOME': '/home/cltbld', 04:35:31 INFO - 'LANG': 'en_US.UTF-8', 04:35:31 INFO - 'LANGUAGE': 'en_US:en', 04:35:31 INFO - 'LOGNAME': 'cltbld', 04:35:31 INFO - 'MAIL': '/var/mail/cltbld', 04:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:31 INFO - 'MOZ_NO_REMOTE': '1', 04:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:31 INFO - 'NO_EM_RESTART': '1', 04:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:31 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:31 INFO - 'SHELL': '/bin/bash', 04:35:31 INFO - 'SHLVL': '1', 04:35:31 INFO - 'TERM': 'linux', 04:35:31 INFO - 'TMOUT': '86400', 04:35:31 INFO - 'USER': 'cltbld', 04:35:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:31 INFO - '_': '/tools/buildbot/bin/python'} 04:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:31 INFO - Downloading/unpacking psutil>=0.7.1 04: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 04: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 04: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 04: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 04: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 04: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 04:35:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:33 INFO - Installing collected packages: psutil 04:35:33 INFO - Running setup.py install for psutil 04:35:33 INFO - building 'psutil._psutil_linux' extension 04:35:33 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 04:35:33 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 04:35:33 INFO - building 'psutil._psutil_posix' extension 04:35:33 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 04:35:34 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 04:35:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:34 INFO - Successfully installed psutil 04:35:34 INFO - Cleaning up... 04:35:34 INFO - Return code: 0 04:35:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 04:35:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:35:34 INFO - Using env: {'DISPLAY': ':0', 04:35:34 INFO - 'HOME': '/home/cltbld', 04:35:34 INFO - 'LANG': 'en_US.UTF-8', 04:35:34 INFO - 'LANGUAGE': 'en_US:en', 04:35:34 INFO - 'LOGNAME': 'cltbld', 04:35:34 INFO - 'MAIL': '/var/mail/cltbld', 04:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:34 INFO - 'MOZ_NO_REMOTE': '1', 04:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:34 INFO - 'NO_EM_RESTART': '1', 04:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:34 INFO - 'SHELL': '/bin/bash', 04:35:34 INFO - 'SHLVL': '1', 04:35:34 INFO - 'TERM': 'linux', 04:35:34 INFO - 'TMOUT': '86400', 04:35:34 INFO - 'USER': 'cltbld', 04:35:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:34 INFO - '_': '/tools/buildbot/bin/python'} 04:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:35:34 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 04:35:34 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 04:35:34 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 04:35:34 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 04:35:34 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 04:35:34 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 04:35:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:35:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:35:36 INFO - Installing collected packages: mozsystemmonitor 04:35:36 INFO - Running setup.py install for mozsystemmonitor 04:35:36 INFO - Successfully installed mozsystemmonitor 04:35:36 INFO - Cleaning up... 04:35:36 INFO - Return code: 0 04:35:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 04:35:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:35:36 INFO - Using env: {'DISPLAY': ':0', 04:35:36 INFO - 'HOME': '/home/cltbld', 04:35:36 INFO - 'LANG': 'en_US.UTF-8', 04:35:36 INFO - 'LANGUAGE': 'en_US:en', 04:35:36 INFO - 'LOGNAME': 'cltbld', 04:35:36 INFO - 'MAIL': '/var/mail/cltbld', 04:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:36 INFO - 'MOZ_NO_REMOTE': '1', 04:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:36 INFO - 'NO_EM_RESTART': '1', 04:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:36 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:36 INFO - 'SHELL': '/bin/bash', 04:35:36 INFO - 'SHLVL': '1', 04:35:36 INFO - 'TERM': 'linux', 04:35:36 INFO - 'TMOUT': '86400', 04:35:36 INFO - 'USER': 'cltbld', 04:35:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:36 INFO - '_': '/tools/buildbot/bin/python'} 04:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:36 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 04:35:36 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 04:35:36 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 04:35:36 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 04:35:36 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 04:35:36 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 04:35:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:38 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 04:35:38 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 04:35:38 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 04:35:38 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 04:35:38 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 04:35:38 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 04:35:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:35:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:39 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 04:35:39 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 04:35:39 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 04:35:39 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 04:35:39 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 04:35:39 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 04:35:39 INFO - Downloading docopt-0.6.1.tar.gz 04:35:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:39 INFO - Running setup.py install for blobuploader 04:35:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:35:39 INFO - Running setup.py install for requests 04:35:39 INFO - Running setup.py install for docopt 04:35:39 INFO - Successfully installed blobuploader requests docopt 04:35:39 INFO - Cleaning up... 04:35:39 INFO - Return code: 0 04:35:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 04:35:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/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 04:35:39 INFO - Using env: {'DISPLAY': ':0', 04:35:39 INFO - 'HOME': '/home/cltbld', 04:35:39 INFO - 'LANG': 'en_US.UTF-8', 04:35:39 INFO - 'LANGUAGE': 'en_US:en', 04:35:39 INFO - 'LOGNAME': 'cltbld', 04:35:39 INFO - 'MAIL': '/var/mail/cltbld', 04:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:39 INFO - 'MOZ_NO_REMOTE': '1', 04:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:39 INFO - 'NO_EM_RESTART': '1', 04:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:39 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:39 INFO - 'SHELL': '/bin/bash', 04:35:39 INFO - 'SHLVL': '1', 04:35:39 INFO - 'TERM': 'linux', 04:35:39 INFO - 'TMOUT': '86400', 04:35:39 INFO - 'USER': 'cltbld', 04:35:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:39 INFO - '_': '/tools/buildbot/bin/python'} 04:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:35:40 INFO - Running setup.py (path:/tmp/pip-pr5ZYL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:35:40 INFO - Running setup.py (path:/tmp/pip-kQ4qgv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:35:40 INFO - Running setup.py (path:/tmp/pip-Jq2AiN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:35:40 INFO - Running setup.py (path:/tmp/pip-XyjYFW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:35:40 INFO - Running setup.py (path:/tmp/pip-9a41Ju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:35:40 INFO - Running setup.py (path:/tmp/pip-A6TbZU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:35:40 INFO - Running setup.py (path:/tmp/pip-UapuEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:35:40 INFO - Running setup.py (path:/tmp/pip-KC8l53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:35:40 INFO - Running setup.py (path:/tmp/pip-8tqLqi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:35:40 INFO - Running setup.py (path:/tmp/pip-W6zfGT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:35:40 INFO - Running setup.py (path:/tmp/pip-rM5H1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:35:40 INFO - Running setup.py (path:/tmp/pip-xCNiEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:35:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:35:41 INFO - Running setup.py (path:/tmp/pip-CkMpSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:35:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:35:41 INFO - Running setup.py (path:/tmp/pip-ExAesq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:35:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:35:41 INFO - Running setup.py (path:/tmp/pip-idkZXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:35:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:35:41 INFO - Running setup.py (path:/tmp/pip-SAkSpC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:35:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:35:41 INFO - Running setup.py (path:/tmp/pip-BnqXRx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:35:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:41 INFO - Running setup.py install for manifestparser 04:35:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:35:41 INFO - Running setup.py install for mozcrash 04:35:41 INFO - Running setup.py install for mozdebug 04:35:41 INFO - Running setup.py install for mozdevice 04:35:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:35:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:35:41 INFO - Running setup.py install for mozfile 04:35:41 INFO - Running setup.py install for mozhttpd 04:35:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:35:41 INFO - Running setup.py install for mozinfo 04:35:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Running setup.py install for mozInstall 04:35:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Running setup.py install for mozleak 04:35:42 INFO - Running setup.py install for mozlog 04:35:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Running setup.py install for moznetwork 04:35:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Running setup.py install for mozprocess 04:35:42 INFO - Running setup.py install for mozprofile 04:35:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Running setup.py install for mozrunner 04:35:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:35:42 INFO - Running setup.py install for mozscreenshot 04:35:42 INFO - Running setup.py install for moztest 04:35:43 INFO - Running setup.py install for mozversion 04:35:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:35:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:43 INFO - Cleaning up... 04:35:43 INFO - Return code: 0 04:35:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 04:35:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 04:35:43 INFO - Using env: {'DISPLAY': ':0', 04:35:43 INFO - 'HOME': '/home/cltbld', 04:35:43 INFO - 'LANG': 'en_US.UTF-8', 04:35:43 INFO - 'LANGUAGE': 'en_US:en', 04:35:43 INFO - 'LOGNAME': 'cltbld', 04:35:43 INFO - 'MAIL': '/var/mail/cltbld', 04:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:43 INFO - 'MOZ_NO_REMOTE': '1', 04:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:43 INFO - 'NO_EM_RESTART': '1', 04:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:43 INFO - 'SHELL': '/bin/bash', 04:35:43 INFO - 'SHLVL': '1', 04:35:43 INFO - 'TERM': 'linux', 04:35:43 INFO - 'TMOUT': '86400', 04:35:43 INFO - 'USER': 'cltbld', 04:35:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:43 INFO - '_': '/tools/buildbot/bin/python'} 04:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:35:43 INFO - Running setup.py (path:/tmp/pip-7Z1Bc4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:35:43 INFO - Running setup.py (path:/tmp/pip-ZD6xe4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:35:43 INFO - Running setup.py (path:/tmp/pip-7lFw98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:35:43 INFO - Running setup.py (path:/tmp/pip-UvGOFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:35:43 INFO - Running setup.py (path:/tmp/pip-npHdpL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:35:43 INFO - Running setup.py (path:/tmp/pip-te85rS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:35:43 INFO - Running setup.py (path:/tmp/pip-GmnXud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:35:43 INFO - Running setup.py (path:/tmp/pip-peI_LH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:35:43 INFO - Running setup.py (path:/tmp/pip-UnN4wy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:35:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:35:44 INFO - Running setup.py (path:/tmp/pip-KktmFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:35:44 INFO - Running setup.py (path:/tmp/pip-k3KUDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:35:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:35:44 INFO - Running setup.py (path:/tmp/pip-P6IjXV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:35:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:35:44 INFO - Running setup.py (path:/tmp/pip-_1qwBu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:35:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:35:44 INFO - Running setup.py (path:/tmp/pip-SYMeRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:35:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:35:44 INFO - Running setup.py (path:/tmp/pip-avClbi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:35:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:35:44 INFO - Running setup.py (path:/tmp/pip-ihYsb3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:35:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:35:44 INFO - Running setup.py (path:/tmp/pip-eUzaHd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:35:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:44 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 04:35:44 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 04:35:44 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 04:35:44 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 04:35:44 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 04:35:44 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 04:35:46 INFO - Downloading blessings-1.6.tar.gz 04:35:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:46 INFO - Installing collected packages: blessings 04:35:46 INFO - Running setup.py install for blessings 04:35:46 INFO - Successfully installed blessings 04:35:46 INFO - Cleaning up... 04:35:46 INFO - Return code: 0 04:35:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:35:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:35:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:35:46 INFO - Reading from file tmpfile_stdout 04:35:46 INFO - Current package versions: 04:35:46 INFO - argparse == 1.2.1 04:35:46 INFO - blessings == 1.6 04:35:46 INFO - blobuploader == 1.2.4 04:35:46 INFO - docopt == 0.6.1 04:35:46 INFO - manifestparser == 1.1 04:35:46 INFO - mozInstall == 1.12 04:35:46 INFO - mozcrash == 0.16 04:35:46 INFO - mozdebug == 0.1 04:35:46 INFO - mozdevice == 0.48 04:35:46 INFO - mozfile == 1.2 04:35:46 INFO - mozhttpd == 0.7 04:35:46 INFO - mozinfo == 0.9 04:35:46 INFO - mozleak == 0.1 04:35:46 INFO - mozlog == 3.1 04:35:46 INFO - moznetwork == 0.27 04:35:46 INFO - mozprocess == 0.22 04:35:46 INFO - mozprofile == 0.28 04:35:46 INFO - mozrunner == 6.11 04:35:46 INFO - mozscreenshot == 0.1 04:35:46 INFO - mozsystemmonitor == 0.0 04:35:46 INFO - moztest == 0.7 04:35:46 INFO - mozversion == 1.4 04:35:46 INFO - psutil == 3.1.1 04:35:46 INFO - requests == 1.2.3 04:35:46 INFO - wsgiref == 0.1.2 04:35:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 04:35:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 04:35:46 INFO - Using env: {'DISPLAY': ':0', 04:35:46 INFO - 'HOME': '/home/cltbld', 04:35:46 INFO - 'LANG': 'en_US.UTF-8', 04:35:46 INFO - 'LANGUAGE': 'en_US:en', 04:35:46 INFO - 'LOGNAME': 'cltbld', 04:35:46 INFO - 'MAIL': '/var/mail/cltbld', 04:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:46 INFO - 'MOZ_NO_REMOTE': '1', 04:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:46 INFO - 'NO_EM_RESTART': '1', 04:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:46 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:46 INFO - 'SHELL': '/bin/bash', 04:35:46 INFO - 'SHLVL': '1', 04:35:46 INFO - 'TERM': 'linux', 04:35:46 INFO - 'TMOUT': '86400', 04:35:46 INFO - 'USER': 'cltbld', 04:35:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:46 INFO - '_': '/tools/buildbot/bin/python'} 04:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:35:47 INFO - Cleaning up... 04:35:47 INFO - Return code: 0 04:35:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 04:35:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:35:47 INFO - Using env: {'DISPLAY': ':0', 04:35:47 INFO - 'HOME': '/home/cltbld', 04:35:47 INFO - 'LANG': 'en_US.UTF-8', 04:35:47 INFO - 'LANGUAGE': 'en_US:en', 04:35:47 INFO - 'LOGNAME': 'cltbld', 04:35:47 INFO - 'MAIL': '/var/mail/cltbld', 04:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:47 INFO - 'MOZ_NO_REMOTE': '1', 04:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:47 INFO - 'NO_EM_RESTART': '1', 04:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:47 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:47 INFO - 'SHELL': '/bin/bash', 04:35:47 INFO - 'SHLVL': '1', 04:35:47 INFO - 'TERM': 'linux', 04:35:47 INFO - 'TMOUT': '86400', 04:35:47 INFO - 'USER': 'cltbld', 04:35:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:47 INFO - '_': '/tools/buildbot/bin/python'} 04:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:47 INFO - Downloading/unpacking jsonschema 04:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:49 INFO - Downloading/unpacking functools32 (from jsonschema) 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:49 INFO - warning: no files found matching '*.txt' 04:35:49 INFO - no previously-included directories found matching 'build' 04:35:49 INFO - no previously-included directories found matching 'dist' 04:35:49 INFO - no previously-included directories found matching '.git*' 04:35:49 INFO - Installing collected packages: jsonschema, functools32 04:35:49 INFO - Running setup.py install for functools32 04:35:49 INFO - warning: no files found matching '*.txt' 04:35:49 INFO - no previously-included directories found matching 'build' 04:35:49 INFO - no previously-included directories found matching 'dist' 04:35:49 INFO - no previously-included directories found matching '.git*' 04:35:49 INFO - Successfully installed jsonschema functools32 04:35:49 INFO - Cleaning up... 04:35:49 INFO - Return code: 0 04:35:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:35: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')]} 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f91b174df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b24230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:35:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 04:35:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:35:49 INFO - Using env: {'DISPLAY': ':0', 04:35:49 INFO - 'HOME': '/home/cltbld', 04:35:49 INFO - 'LANG': 'en_US.UTF-8', 04:35:49 INFO - 'LANGUAGE': 'en_US:en', 04:35:49 INFO - 'LOGNAME': 'cltbld', 04:35:49 INFO - 'MAIL': '/var/mail/cltbld', 04:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:49 INFO - 'MOZ_NO_REMOTE': '1', 04:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:35:49 INFO - 'NO_EM_RESTART': '1', 04:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:35:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:35:49 INFO - 'SHELL': '/bin/bash', 04:35:49 INFO - 'SHLVL': '1', 04:35:49 INFO - 'TERM': 'linux', 04:35:49 INFO - 'TMOUT': '86400', 04:35:49 INFO - 'USER': 'cltbld', 04:35:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:49 INFO - '_': '/tools/buildbot/bin/python'} 04:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:49 INFO - Downloading/unpacking flake8 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:35:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:35:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:35:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:35:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:35:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:35:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:35:52 INFO - no previously-included directories found matching 'docs/_build' 04:35:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:35:52 INFO - Running setup.py install for pep8 04:35:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:35:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:35:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:35:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:35:52 INFO - no previously-included directories found matching 'docs/_build' 04:35:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:35:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:35:52 INFO - Cleaning up... 04:35:52 INFO - Return code: 0 04:35:52 INFO - Running post-action listener: _resource_record_post_action 04:35:52 INFO - Running post-action listener: _start_resource_monitoring 04:35:52 INFO - Starting resource monitoring. 04:35:52 INFO - ##### 04:35:52 INFO - ##### Running install step. 04:35:52 INFO - ##### 04:35:52 INFO - Running pre-action listener: _resource_record_pre_action 04:35:52 INFO - Running main action method: install 04:35:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:35:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:35:52 INFO - Reading from file tmpfile_stdout 04:35:52 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:35:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:35:52 INFO - Reading from file tmpfile_stdout 04:35:52 INFO - Output received: 04:35:52 INFO - Usage: mozinstall [options] installer 04:35:52 INFO - Options: 04:35:52 INFO - -h, --help show this help message and exit 04:35:52 INFO - -d DEST, --destination=DEST 04:35:52 INFO - Directory to install application into. [default: 04:35:52 INFO - "/builds/slave/test-pgo"] 04:35:52 INFO - --app=APP Application being installed. [default: firefox] 04:35:52 INFO - mkdir: /builds/slave/test-pgo/build/application 04:35:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:35:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:36:07 INFO - Reading from file tmpfile_stdout 04:36:07 INFO - Output received: 04:36:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:36:07 INFO - Running post-action listener: _resource_record_post_action 04:36:07 INFO - ##### 04:36:07 INFO - ##### Running run-tests step. 04:36:07 INFO - ##### 04:36:07 INFO - Running pre-action listener: _resource_record_pre_action 04:36:07 INFO - Running main action method: run_tests 04:36:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:36:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:36:07 INFO - Python 2.7.3 04:36:07 INFO - Return code: 0 04:36:07 INFO - grabbing minidump binary from tooltool 04:36: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')]} 04:36:07 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-pgo/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 0x1bb67f0>, '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 0x1b222d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b22760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:36:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:36:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:36:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:08 INFO - Return code: 0 04:36:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:36:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:36:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:36:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:36:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:36:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:36:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:36:09 INFO - Return code: 0 04:36:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 04:36:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:36:09 INFO - Using env: {'DISPLAY': ':0', 04:36:09 INFO - 'HOME': '/home/cltbld', 04:36:09 INFO - 'LANG': 'en_US.UTF-8', 04:36:09 INFO - 'LANGUAGE': 'en_US:en', 04:36:09 INFO - 'LOGNAME': 'cltbld', 04:36:09 INFO - 'MAIL': '/var/mail/cltbld', 04:36:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:36:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:09 INFO - 'MOZ_NO_REMOTE': '1', 04:36:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:09 INFO - 'NO_EM_RESTART': '1', 04:36:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:36:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:36:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:36:09 INFO - 'SHELL': '/bin/bash', 04:36:09 INFO - 'SHLVL': '1', 04:36:09 INFO - 'TERM': 'linux', 04:36:09 INFO - 'TMOUT': '86400', 04:36:09 INFO - 'USER': 'cltbld', 04:36:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537', 04:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:09 INFO - '_': '/tools/buildbot/bin/python'} 04:36:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:36:09 INFO - mozversion application_buildid: 20160224015246 04:36:09 INFO - mozversion application_changeset: 03725a09cbb51cbda9d9b7e1de0b0873d5bbc321 04:36:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:36:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:09 INFO - mozversion application_name: Firefox 04:36:09 INFO - mozversion application_remotingname: firefox-dev 04:36:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:36:09 INFO - mozversion application_vendor: Mozilla 04:36:09 INFO - mozversion application_version: 46.0a2 04:36:09 INFO - mozversion platform_buildid: 20160224015246 04:36:09 INFO - mozversion platform_changeset: 03725a09cbb51cbda9d9b7e1de0b0873d5bbc321 04:36:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:36:09 INFO - mozversion platform_version: 46.0a2 04:36:09 INFO - using testdate: 1456317369 04:36:09 INFO - actual date: 1456317369 04:36:09 INFO - starting webserver on 'localhost:56991' 04:36:09 INFO - SUITE-START | Running 3 tests 04:36:09 INFO - TEST-START | dromaeo_css 04:36:09 INFO - operating with platform_type : linux_ 04:36:09 INFO - Initialising browser for dromaeo_css test... 04:36:09 INFO - TEST-INFO | started process 12746 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprGsrkN/profile http://localhost:56991/getInfo.html) 04:36:12 INFO - PROCESS | 12746 | 04:36:12 INFO - PROCESS | 12746 | (process:12827): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:36:13 INFO - PROCESS | 12746 | __metrics Screen width/height:1600/1200 04:36:13 INFO - PROCESS | 12746 | colorDepth:24 04:36:13 INFO - PROCESS | 12746 | Browser inner width/height: 1024/697 04:36:13 INFO - PROCESS | 12746 | __metrics 04:36:14 INFO - TEST-INFO | 12746: exit 0 04:36:14 INFO - Browser initialized. 04:36:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:36:14 INFO - TEST-INFO | started process 12876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprGsrkN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:16 INFO - PROCESS | 12876 | 04:36:16 INFO - PROCESS | 12876 | (process:12939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:36:26 INFO - PROCESS | 12876 | RSS: Main: 141541376 04:36:26 INFO - PROCESS | 12876 | 04:37:16 INFO - PROCESS | 12876 | 1456317436287 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] 04:39:24 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:56991/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56991/tests/dromaeo/cssquery-ext.html) 04:39:25 INFO - PROCESS | 12876 | RSS: Main: 145723392 04:39:25 INFO - PROCESS | 12876 | 04:42:27 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:56991/tests/dromaeo/cssquery-ext.html (next: http://localhost:56991/tests/dromaeo/cssquery-jquery.html) 04:42:27 INFO - PROCESS | 12876 | RSS: Main: 144654336 04:42:27 INFO - PROCESS | 12876 | 04:45:29 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:56991/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56991/tests/dromaeo/cssquery-mootools.html) 04:45:29 INFO - PROCESS | 12876 | RSS: Main: 143613952 04:45:29 INFO - PROCESS | 12876 | 04:48:31 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:56991/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56991/tests/dromaeo/cssquery-prototype.html) 04:48:32 INFO - PROCESS | 12876 | RSS: Main: 142934016 04:48:32 INFO - PROCESS | 12876 | 04:51:34 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:56991/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56991/tests/dromaeo/cssquery-yui.html) 04:51:34 INFO - PROCESS | 12876 | RSS: Main: 143405056 04:51:34 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | Cycle 1(1): loaded http://localhost:56991/tests/dromaeo/cssquery-yui.html (next: http://localhost:56991/tests/dromaeo/cssquery-dojo.html) 04:54:37 INFO - PROCESS | 12876 | RSS: Main: 146821120 04:54:37 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | __start_tp_report 04:54:37 INFO - PROCESS | 12876 | _x_x_mozilla_page_load 04:54:37 INFO - PROCESS | 12876 | _x_x_mozilla_page_load_details 04:54:37 INFO - PROCESS | 12876 | |i|pagename|runs| 04:54:37 INFO - PROCESS | 12876 | |0;dojo.html;3381.188514756458;3381.5942086949585;3393.9490907636405;3418.128377263799;3422.4010798110326;5472.699001554918;5510.752016159272;5511.338639363277;5512.669239845602;5534.861628459291;5516.834494965157;5534.501894829465;5549.861253468665;5553.250311207986;5593.272874526316;5015.796208909854;5058.317127187819;5091.745412729368;5127.692338459704;5169.663971841837;4868.853934381974;5042.445331013604;5045.34410526631;5066.518680725325;5171.948280517185;5049.3940727112795;5126.92309615356;5141.15170996785;5143.897122057557;5161.793528258865;5035.219540971156;5044.2937988681615;5049.0406822703935;5053.722045287508;5093.185090385539;4938.950610493885;4953.405591329064;4979.601631869478;4989.251612258154;4998.500149985009;4779.593734532569;5243.554297884684;5249.737513124367;5307;5325.4940780625775;5886.852828679274;5902.498287645555;5923.763049478016;5949.375315591844;5950.375210602911;5847.766089356421;5985.910211346833;5986.580939334249;5992.940070599282;5994.760209591611;5517.420670829545;5605.495505404492;5655.26481557399;5665.631733937281;5702.144678298247;6038.849028774228;6072;6076.787312444043;6100.481459076028;6112.17485639433;5764.394738552475;5832.154337621106;5840.853978650568;5875.618084824473;5901.557383196277;5876.882462350729;5966.134910437962;5967.8209653710455;5975.103734439782;6011;5813.273340832396;5841.357450680422;5892.057270836732;5916.704164791743;5954.732037058343;5762.769489220468;5829.504492118217;5890.676012819336;5897.705114744245;5903.527717782567;4460.531644177315;4497.460304763449;4505.617022553054;4563.087382523442;4584.15193189261;3993.9016770388375;4056.411820286042;4072.2466343726505;4094.2220978014084;4094.344904815215;5521.089020311603;5529.115341545334;5609.6353737007785;5612.186232996192;5646.124850648156;5848.9707551462825;5869.178315035899;5948.85127871798;6007.068904319837;6043.848903777441;5521.475459831309;5523.558115350762;5567.860803479945;5576.052071147915;5601.971990140105;4960.404751429852;5074.162763144113;5080.49195080489;5087.109755792721;5124.026434977342;5961.135635332853;5969.731362088716;5975.790847320323;5980.282366116094;6120.693965301806;5946.672932988728;5983.55123365758;5994.460498555151;5997.310309314485;6019.909701354483;6049;6057.636541807506;6104.938950610437;6121.785737499166;6130.264368275835;5662.405447428126;5778.8266352009505;5800.883982320414;5802.361740208489;5903.557233207441;5894.646321220741;5928.407159284209;5942.405759424023;5946.07835785454;5954.553408494294;5722.3991480895575;5754;5776.451237132465;5791.160281759037;5793.91309130355;5608.579356548356;5722.599418040697;5742.339630942495;5749.367569567261;5794.101914203306;5704.286964129484;5714.771409143587;5721.914171287351;5735.8852822944145;5786.739596718242;5759.366469688247;5809.419058094157;5862.970685146547;5891.852703682443;5912.408759124053;5649.858753531194;5686.800961966312;5721.9700453918695;5748.6838223898085;5766.077427611562 04:54:37 INFO - PROCESS | 12876 | |1;ext.html;548.9094299440595;557.7713137613578;567.804107582884;580.1906340654784;589.4341432225063;37605.81197094014;38517.42223866644;38809.22381552371;38810.41784373233;38839.417408738824;40872.79563602185;41626.58373416273;41680;41842.790786046105;41852;8816.603252853605;8873.668949657538;8944.926608806953;9030.683926062557;9038.548072596377;8745.825083498326;8880.245179159747;8884.555772211395;9055.230305424047;9092.772680683003;9035.141661542142;9132.634694612207;9176.72469825903;9182.403143795633;9188.035256298093;8917.197452229299;8984.46093234408;9056.184943355129;9070.229030532413;9072.8639070414;8809.295256379539;8855;8903.24322432594;8919.286457083483;8930.017698053209;43076.78461607672;43343.566564334265;43622.56377436217;43661;43699.12601747979;3372.4772660237704;3535.7878527288444;3569.5002699622073;4079.3269110596716;4325.221460137174;32250;32291.19272018195;32722.509162362585;33084.834575827204;33729.15677108092;4229.577042295777;4230.7038507304505;4281.571842815724;4312.439382880206;4384.013596940663;305574;310822;310912;311557;313100;44850.77574612171;45405.77297113493;45413.772931135136;45599.31601025987;67526.32473675298;43729.781351093676;43736.78131609385;43809.78095109504;43837.12325753467;44014.11971760611;16715.080670563235;16790.412335568442;16837.073960932266;16860.57848553796;16950.23723932426;13461.259630720404;13485.258310792804;13570.660733481742;13572.1856688599;13656.907447404184;15469.845301547066;15482.22588870552;15522.146281954376;15563.066216027075;15613.171272483882;6046.3349031606485;6145.661988590581;6178.258608966953;6224.097505861625;6242.687865606701;1009.3388830316155;1021.7190272674925;1091.1489038549944;1158.2413519144973;1164.9690024328531;27584.862075689492;27649.585256221173;28025.43949121006;28390.432191356056;28570;1105.1435137768133;1127.447550700151;1151.2171723228118;1171.701216189866;1199.2624535910352;15022;15079.170645614377;15132.773008404884;15153;15353.692926141415;482334;509723;515372;807410.7406240753;810987;55504.44495555074;56080;56105.43894561084;56153.43846561564;56265.15602265969;1492.5522343296968;1502.3990403838334;1515.3559737111684;1517.2944580769774;1518.582389842802;28725.28186795347;30029.099127026224;31913.68086319107;32278.35443291168;33094.5035824458;48914.266286005026;49512.257316141004;49621;49659.503404965486;49957;307594;307822;311630;312348;312502;33533.664663353054;34764.652353477155;35001;35099.82450087733;35121.47317790184;45745.54254457413;45924.54075459336;45999;46567.53432465632;47224;39202.80398597989;39253.80373098116;40210.597894020684;40237;40813.591864080976;39800;39940.2011959765;40598.79700601478;40647.39028914509;41319;36709.63290367062;37443.62556374401;37516.62483375131;37626;37759.244815104095;31820.68179318177;32041.67958320387;32589.837050814593;32591.837040815593;32761.672383276815;25055.248342549752;25559.616605750558;27068.729312707408;27355.589666154625;27359.45281094407 04:54:37 INFO - PROCESS | 12876 | |2;jquery.html;396.3480075276171;399.76214152579206;399.9420084087806;404.23195927737277;407.088122605364;14933.551993440187;15463.69072618547;17326;17837.64324713505;17886.10569471526;10952.780944381107;11276.154288428359;16441.753373699376;18200.27198912045;18234;4554.863354099374;5875.823725288248;5880.26496687914;5882.411758824126;5912.142739302799;5171.146760784485;5382.4886635769535;5389.676619402849;5414.242006119146;5765.135229715555;5127.7948882044675;5214;5246.842594722164;5408.161734931073;5416.702081385522;5462.071447853875;5469.699166545838;5507.972460137694;5512.751926163312;5753.252077229933;5614.27014488118;5616.887662246773;5618.073017952033;5636.098224284095;5734.340550836666;12689.175203611736;18976.62046759071;19142.425727228205;19603.411897643095;21486.355409337746;2171.9782802171935;2183.1376606240447;2232.6092933736695;2271.1710225767474;2323.1288266899915;6730.091437655903;7375.336219740249;9262.6294948202;9750.658726944523;9770.560324785401;1821.1895706410653;1899.3162461513843;1910.1404368034441;1941.5049162463622;2033.9084741186682;60991.69504152495;62188.37811621871;63535.68232158856;63922.68038659824;65080;10775.892241077645;11021.724456888642;11046.668599942015;11085.27945683528;11099.944500277446;14716.043457175248;14775.92612036933;14778.556643300719;14813.185274809988;14861.479848205261;8571.314294856396;8579.056303806576;8619.310455163697;8662.826743465095;8678.609462574073;8427.452215606088;8464.492130472192;8482.872756908651;8519.105493923173;8565.10066443027;4722.079194557097;4814.807407703653;7712.537247765152;8021.27808497238;8025.197480252044;3138.9686103139134;3182.6791881369436;3235.5955505561806;3266.4936934774673;3283.7865538739907;941.5010044676333;999.0908273471251;1056.5562463765236;1066.594694016269;1085.5277954089995;17147.056911869968;17422.738658920127;17638.647227055386;17702.734458983126;18267.177976991068;1013.2805707947292;1035.0942924940678;1045.3727763341933;1050.826613608746;1152.2280072351546;9401.388909720983;9511.524423778783;9553;9579.233661307078;9758.219342452587;425039;430280;431209;435114;642924;78898;78967.60516197383;80353.19646803457;80502.59748701219;83403.5829820847;1244.807054906491;1249.8562665293607;1253.6677780388204;1272.5927703135094;1298.026480139895;15872.682546349239;15889.443869464514;16003;16119.597010074373;16234.350625974828;33149.834250829554;33949;34256.143596410286;34912;36029.63970360368;43592.34611480894;44466.333005005596;45247.321290180014;46318.53681463142;46493.76753116213;7565.6973721050545;7692.538447693157;7710.306072453506;8217.05503867039;8319.417640765088;9238.630454781733;12004.879951200377;12021.879781202077;12314.384280785745;12331.260124392205;3332.6167490738876;3335.8832440864453;3942.64516193544;8516.740195956092;11148.989772761472;10688.89311106879;10905.400202988594;11185.66443006711;11267.549298027987;11287.7742445149;11073.889261107286;11331.150163737588;11375.43122843838;11411.828822567502;11586.246893951866;7723.729669461542;7794.181610930771;7952.363810894999;7999.240072193133;8059.637316320663;10574.735631609272;11030.613928512463;11145;11222.326660400402;11227 04:54:37 INFO - PROCESS | 12876 | |3;mootools.html;1581.0829718763118;1606.1407147176262;1851.93518226862;1916.4633902507303;1958.5495336072704;8405.453645513036;8509.106543812903;8631.093735157812;8653.913460865397;8685.47887126773;8705.564721763902;8710.782230444227;8757.299416046717;8821.603027863746;8831;2383.833131680783;2393.1504315967886;2401.987990060047;2403.7836594706473;2405.20628192696;2373.145667559686;2428;2436.8050555955483;2439.2682195341417;2446.388402899275;2368.348704106367;2414.0343862454984;2422.2975337152207;2431.294924471901;2437.6587277781123;2369.158948573249;2416.6012607919674;2427.6844010278637;2444.9022039118504;2445.254197469771;2377.7741114594087;2407.41018450479;2407.8675672837985;2412.0110754590532;2421.6004359280696;8188.385871059694;8197.877031844528;8266.380021498411;8270.172982701743;8294.253517183422;5032.4967503249745;5056.949430505685;5117.2068329409;5146.356705411824;5166.61250406221;3239.7894136881264;3254.625718042432;3275.459549174407;3298.736101111905;3311.6522765109557;1170.9648710538697;1175.1304035014027;1200.1658847101269;1205.843240378754;1218.6831423829778;11802.586909458129;11872.10959178065;11921.642350729491;11942.044636429151;12021.879781202164;4317.179735850241;4326.956730432656;4365.694401391872;4384.254676704904;4413.514513403523;9692.903070969342;9707.757306067264;9712.22302215821;9812.62623232748;9814.263930205121;4955.35580374549;4973.726445045485;5020.974895125501;5021.472745361758;5037.471065538139;4539.977300113478;4554.63562914966;4603.769811509411;4607;4644.094401591725;3642.4354225095153;3668.2296717689583;3688.1517251032415;3704.518412606344;3734.6452087051684;1044.6761503933806;1073.6725298783947;1093.775775965925;1102.3330884814732;1105.4307031878589;1148.542119863476;1179.6461061681632;1214.9028077753758;1492.8283247426468;1497.9026363286569;7899.447038707235;7924.6037698116015;8052.758417247492;8059.597020149086;8066.556339401389;683.5147045597681;690.3579670906106;693.8785712500293;696.5681277607915;832.3341326938425;6162.044883043135;6176.722047507783;6178.165947597106;6180.81457556274;6209.192804935329;9942.154916832005;10264.332818366782;10279.331843430153;10301.433421161908;10328.896711032794;9949;10011.199104071657;10068.144207742424;10104.242181836391;10152.949235253776;7507.812304692317;7673.961630191925;7786.338161256356;7815.062192537046;7823.295903368724;7670.156282808775;7671.38628909697;7698.230176982481;7721.073471183494;7735;9301.116393942564;9393.671221507488;9479.146876781122;9514.571844267162;9621.855672165064;9066.36535442539;9174;9666.130048295687;9674.274429417681;9765.707028789147;7651.120121186135;7843;7857.646405911862;7862.60686965638;7880.802979925318;8207.097219305751;8317.085120636604;8338.708145214889;8371.121032291521;8388.790280243044;7516.210797866364;7839.25527074927;7925.841483170419;7952.721654742057;8040.356771458152;7469.701211951461;7666.540007599562;7684.6157692116285;7788.260115289038;7803.297703206738;7712.884306735516;7742.38060955111;7771.650275737718;7786.805329866798;7798.961005194938;6864.347886950732;7015.298470152944;7025.894611580932;7032.542884712478;7037.7888663338135;7227.060482137288;7276.745313913988;7316.414686825147;7326.853462930605;7329.853402931805 04:54:37 INFO - PROCESS | 12876 | |4;prototype.html;380.36099353086814;381.12341614287135;383.2067620026546;384.7345331721114;385.39685392360946;6388.744450221986;6399.616023038621;6440.516961227903;6457.6448295343735;6631.767888123916;6406.295307516181;6415.422611964922;6418.037294405842;6436.098946147543;6484.319146489622;4928.457869634337;4955.479674634165;4965.031818795336;4973.701577905319;4978.377702787152;4970.87572810679;4978.477259887714;4986.252062190664;4987.476314986929;4988.877502561931;4575.359449677047;4883.487233840431;4919.089968355847;4923.18767403378;4925.458199598042;4880.316755654211;4888.535589119028;4895.5838753705975;4898.436679781835;4908.361912951329;4301.5698430156735;4317.050248945227;4318.4170137031415;4319.352097185416;4332.891677708051;6083.6045657032155;6144;6192.349803270637;6216.254049514042;6230.626162430223;5753.338366087912;5754.654720716729;5757.539396848242;5764.135379693038;5766.221560089376;6729.49528785343;6767.1879374475375;6788.9660551696925;6792.66036698168;6812.557183783038;4718.551737584924;4768.690035147704;4789.976050119727;4804.831830885937;4804.927926081112;6922.169339679221;7119.430445564394;7144.821379465555;7151;7174;4911.950880491221;4914.778834952435;4927.77824997876;4928.457869634337;4936.6297527685565;4981.476944920803;4982.078315511642;4994.80020799164;4995.125852975715;5003.574696150795;5609.411011843697;5670.461306175906;5728.112142617901;5728.169415434739;5745.683987380734;6837.111175547247;6856.24581296057;6870.072540207008;6872.896906546406;6885.483588730865;1722.431597572798;1738.782652168479;1745.825417458244;1753.587906841891;1758.358199257262;1172.5427083437467;1183.360985068071;1194.808830587102;1196.2882085159317;1215.8480189976253;6482.384173503509;6554.639494827735;6565;6588.703508342136;6589.868202636017;6954.756583519553;6991.44068474531;7002.579845209202;7007.719691212396;7010.369066784014;6419.422251997343;6480;6518.57629254097;6568.507361947873;6572.178477690289;3777.3578491656485;3799.0122568131933;3802.771833689932;3810.657040866335;3811.504504414464;7129.572225666477;7137.2149063602965;7151.606661633556;7170.533915295489;7202.675879585431;7080.893786593102;7101.751438699621;7115.6086415247655;7142.071530700976;7338.22948590401;7355.190928997806;7363.15323737777;7365.274848306054;7368.4842061055215;7388.076490438695;7109.360157585842;7143.82140446493;7149.177844547944;7155.785326440215;7176.7846964591145;6848.520603557703;7014.824629384306;7031.226565077735;7041.718331266692;7048.964755176191;7266.854662906607;7294.96352518234;7327.303906128909;7343.44924130703;7360.374368178765;4934.851954441229;4947.752612369439;4954.430240522242;4974.403071631427;4977.651564390458;6953.965230173817;6964.9900764389895;7003.089598352181;7142.607156606437;7144.285571442814;6865;6911.3779759819845;6913.5506192097355;6917.654117294216;6941.791746247621;6920.550164239308;6935.791926242221;6978.70893884633;6979.930200697928;6990.126234220723;6581.703823327866;6652.501062420241;6708.060871477899;6719.596824190564;6748.628825414649;6868.690908909011;6888.276730943179;6889.724411023503;6906.758263460755;6959.060526828814;6787.966060169668;6793.98090286461;6807.285235050248;6838.350356716104;6872.450203983769 04:54:37 INFO - PROCESS | 12876 | |5;yui.html;915.6932427636741;918.6692790595384;918.8208299381619;939.2204470289661;953.9236861051116;14090.859091409096;14215.147091174536;14251.144931304103;14289.928550357246;15751.684966300667;15728.213589320545;15780.368785248576;15785;15803.367865285374;15805.051696898194;871.1245198575455;878.0911756332198;879.683314006957;888.0985799413601;892.2772554231094;874.4971641306242;882.8455020371441;886.1404437695458;903.7695387676133;909.0545832334365;935.1116439382614;935.9859602105973;938.1228551304519;939.736873675372;941.1106504353389;923.1368670293264;923.5382308845577;926.4580220570974;927.7263207353847;930.5951910918739;683.596677960001;685.8971154326841;689.1282527602586;689.2039694153211;690.2166041542835;15064.774028389584;15072.095674259579;15199.696006079927;15215.315310810929;15216.543503694907;13976.93011534946;14022.088564243393;14029;14183.43266269348;14218.715625687428;11587.594434194763;11925.284482931052;11931.761364772656;12002.890821641342;12032.157748957576;3812.1803812180237;3867.5939026402384;3894.610538946111;3903.902402439933;3946.7039972001926;53603;53703.462965370236;54563.72718136424;54665.99337036501;54735.45264547344;10610.681679549625;10952.945235273932;11048.392338421463;11184.496697648625;11420;19463.902680486506;19562.413127606196;19570.70643940342;19600.90199548993;19651.72263802848;7936.246056624727;7980.920190798134;8059.83880322402;8144.104148543655;8255.917440825635;4417.3815665806815;4483.596476317147;4601.493835678073;4709.693869898446;4818.229083346648;3306.834658267077;3368.4105281575626;3373.8313084345687;3374.1901943533376;3382;604.4861867412752;604.8366940925926;609.1319869186392;610.5603965145089;627.4290395739855;620.1937481274325;687.028972538727;687.656171914043;693.4591019005184;720.7441358317826;8878.334124940655;8946.955265223762;9124.315676324302;9239.676611318571;9327.347085703936;681.8295426143465;706.7667669668997;712.5048091576305;712.682856129028;743.6356185469081;4175.290200665894;4261.509926358446;4498.190325741398;4529.9547004530195;4544.613707834871;59316.70341648264;61814;66008;66077;66919.66540167268;54953.72523137359;56059.43940560624;56098;56203.71898140483;57140.14289785657;49391.0121797562;51105.48894511082;51368.74315628398;51374.74312628413;52258;9627.422354658744;9635.13283804461;9811.215102791617;9831.754206144904;10052.246081543768;35971.28057438784;36079.45880811737;36276;36723.265534688624;36999.81500092482;45095.77452112718;49800;50044.49955500398;50495.74752126216;50841;11830.46762895689;11933;11949.21954639703;12166.635000949986;12319;12514.31171285588;12587.433565489759;13055;13254.53609123676;13690.65773355674;12749.362531873183;12899.290539020069;12924.483020679067;13031.218126912416;13190;12542;12672.87327126717;12715.93642031784;13074.869251307366;13173.341332933507;12219.144659874079;12957.481700731865;13293;13304.068715189844;13560.728785424433;9966.950165249127;10151.238657100896;10339.896601034194;10383.428911409945;10452.372857628263;10005.078720162495;10545.31455455393;10615.256932014685;10638.41488718128;10702.518386672462 04:54:37 INFO - PROCESS | 12876 | __end_tp_report 04:54:37 INFO - PROCESS | 12876 | __start_cc_report 04:54:37 INFO - PROCESS | 12876 | _x_x_mozilla_cycle_collect,296 04:54:37 INFO - PROCESS | 12876 | __end_cc_report 04:54:37 INFO - PROCESS | 12876 | __startTimestamp1456318477428__endTimestamp 04:54:37 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | ------- Summary: start ------- 04:54:37 INFO - PROCESS | 12876 | Number of tests: 6 04:54:37 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | [#0] dojo.html Cycles:165 Average:5496.49 Median:5721.97 stddev:601.02 (10.5%) stddev-sans-first:579.50 04:54:37 INFO - PROCESS | 12876 | Values: 3381.2 3381.6 3393.9 3418.1 3422.4 5472.7 5510.8 5511.3 5512.7 5534.9 5516.8 5534.5 5549.9 5553.3 5593.3 5015.8 5058.3 5091.7 5127.7 5169.7 4868.9 5042.4 5045.3 5066.5 5171.9 5049.4 5126.9 5141.2 5143.9 5161.8 5035.2 5044.3 5049.0 5053.7 5093.2 4939.0 4953.4 4979.6 4989.3 4998.5 4779.6 5243.6 5249.7 5307.0 5325.5 5886.9 5902.5 5923.8 5949.4 5950.4 5847.8 5985.9 5986.6 5992.9 5994.8 5517.4 5605.5 5655.3 5665.6 5702.1 6038.8 6072.0 6076.8 6100.5 6112.2 5764.4 5832.2 5840.9 5875.6 5901.6 5876.9 5966.1 5967.8 5975.1 6011.0 5813.3 5841.4 5892.1 5916.7 5954.7 5762.8 5829.5 5890.7 5897.7 5903.5 4460.5 4497.5 4505.6 4563.1 4584.2 3993.9 4056.4 4072.2 4094.2 4094.3 5521.1 5529.1 5609.6 5612.2 5646.1 5849.0 5869.2 5948.9 6007.1 6043.8 5521.5 5523.6 5567.9 5576.1 5602.0 4960.4 5074.2 5080.5 5087.1 5124.0 5961.1 5969.7 5975.8 5980.3 6120.7 5946.7 5983.6 5994.5 5997.3 6019.9 6049.0 6057.6 6104.9 6121.8 6130.3 5662.4 5778.8 5800.9 5802.4 5903.6 5894.6 5928.4 5942.4 5946.1 5954.6 5722.4 5754.0 5776.5 5791.2 5793.9 5608.6 5722.6 5742.3 5749.4 5794.1 5704.3 5714.8 5721.9 5735.9 5786.7 5759.4 5809.4 5863.0 5891.9 5912.4 5649.9 5686.8 5722.0 5748.7 5766.1 04:54:37 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | [#1] ext.html Cycles:180 Average:56747.12 Median:39870.10 stddev:120457.38 (302.1%) stddev-sans-first:120721.39 04:54:37 INFO - PROCESS | 12876 | Values: 548.9 557.8 567.8 580.2 589.4 37605.8 38517.4 38809.2 38810.4 38839.4 40872.8 41626.6 41680.0 41842.8 41852.0 8816.6 8873.7 8944.9 9030.7 9038.5 8745.8 8880.2 8884.6 9055.2 9092.8 9035.1 9132.6 9176.7 9182.4 9188.0 8917.2 8984.5 9056.2 9070.2 9072.9 8809.3 8855.0 8903.2 8919.3 8930.0 43076.8 43343.6 43622.6 43661.0 43699.1 3372.5 3535.8 3569.5 4079.3 4325.2 32250.0 32291.2 32722.5 33084.8 33729.2 4229.6 4230.7 4281.6 4312.4 4384.0 305574.0 310822.0 310912.0 311557.0 313100.0 44850.8 45405.8 45413.8 45599.3 67526.3 43729.8 43736.8 43809.8 43837.1 44014.1 16715.1 16790.4 16837.1 16860.6 16950.2 13461.3 13485.3 13570.7 13572.2 13656.9 15469.8 15482.2 15522.1 15563.1 15613.2 6046.3 6145.7 6178.3 6224.1 6242.7 1009.3 1021.7 1091.1 1158.2 1165.0 27584.9 27649.6 28025.4 28390.4 28570.0 1105.1 1127.4 1151.2 1171.7 1199.3 15022.0 15079.2 15132.8 15153.0 15353.7 482334.0 509723.0 515372.0 807410.7 810987.0 55504.4 56080.0 56105.4 56153.4 56265.2 1492.6 1502.4 1515.4 1517.3 1518.6 28725.3 30029.1 31913.7 32278.4 33094.5 48914.3 49512.3 49621.0 49659.5 49957.0 307594.0 307822.0 311630.0 312348.0 312502.0 33533.7 34764.7 35001.0 35099.8 35121.5 45745.5 45924.5 45999.0 46567.5 47224.0 39202.8 39253.8 40210.6 40237.0 40813.6 39800.0 39940.2 40598.8 40647.4 41319.0 36709.6 37443.6 37516.6 37626.0 37759.2 31820.7 32041.7 32589.8 32591.8 32761.7 25055.2 25559.6 27068.7 27355.6 27359.5 04:54:37 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | [#2] jquery.html Cycles:180 Average:26477.09 Median:2169.50 stddev:78805.16 (3632.4%) stddev-sans-first:79001.89 04:54:37 INFO - PROCESS | 12876 | Values: 396.3 399.8 399.9 404.2 407.1 14933.6 15463.7 17326.0 17837.6 17886.1 10952.8 11276.2 16441.8 18200.3 18234.0 4554.9 5875.8 5880.3 5882.4 5912.1 5171.1 5382.5 5389.7 5414.2 5765.1 5127.8 5214.0 5246.8 5408.2 5416.7 5462.1 5469.7 5508.0 5512.8 5753.3 5614.3 5616.9 5618.1 5636.1 5734.3 12689.2 18976.6 19142.4 19603.4 21486.4 2172.0 2183.1 2232.6 2271.2 2323.1 6730.1 7375.3 9262.6 9750.7 9770.6 1821.2 1899.3 1910.1 1941.5 2033.9 60991.7 62188.4 63535.7 63922.7 65080.0 10775.9 11021.7 11046.7 11085.3 11099.9 14716.0 14775.9 14778.6 14813.2 14861.5 8571.3 8579.1 8619.3 8662.8 8678.6 8427.5 8464.5 8482.9 8519.1 8565.1 4722.1 4814.8 7712.5 8021.3 8025.2 3139.0 3182.7 3235.6 3266.5 3283.8 941.5 999.1 1056.6 1066.6 1085.5 17147.1 17422.7 17638.6 17702.7 18267.2 1013.3 1035.1 1045.4 1050.8 1152.2 9401.4 9511.5 9553.0 9579.2 9758.2 425039.0 430280.0 431209.0 435114.0 642924.0 78898.0 78967.6 80353.2 80502.6 83403.6 1244.8 1249.9 1253.7 1272.6 1298.0 15872.7 15889.4 16003.0 16119.6 16234.4 33149.8 33949.0 34256.1 34912.0 36029.6 43592.3 44466.3 45247.3 46318.5 46493.8 7565.7 7692.5 7710.3 8217.1 8319.4 9238.6 12004.9 12021.9 12314.4 12331.3 3332.6 3335.9 3942.6 8516.7 11149.0 10688.9 10905.4 11185.7 11267.5 11287.8 11073.9 11331.2 11375.4 11411.8 11586.2 7723.7 7794.2 7952.4 7999.2 8059.6 10574.7 11030.6 11145.0 11222.3 11227.0 04:54:37 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | [#3] mootools.html Cycles:180 Average:5943.47 Median:6179.49 stddev:3153.46 (51.0%) stddev-sans-first:3145.26 04:54:37 INFO - PROCESS | 12876 | Values: 1581.1 1606.1 1851.9 1916.5 1958.5 8405.5 8509.1 8631.1 8653.9 8685.5 8705.6 8710.8 8757.3 8821.6 8831.0 2383.8 2393.2 2402.0 2403.8 2405.2 2373.1 2428.0 2436.8 2439.3 2446.4 2368.3 2414.0 2422.3 2431.3 2437.7 2369.2 2416.6 2427.7 2444.9 2445.3 2377.8 2407.4 2407.9 2412.0 2421.6 8188.4 8197.9 8266.4 8270.2 8294.3 5032.5 5056.9 5117.2 5146.4 5166.6 3239.8 3254.6 3275.5 3298.7 3311.7 1171.0 1175.1 1200.2 1205.8 1218.7 11802.6 11872.1 11921.6 11942.0 12021.9 4317.2 4327.0 4365.7 4384.3 4413.5 9692.9 9707.8 9712.2 9812.6 9814.3 4955.4 4973.7 5021.0 5021.5 5037.5 4540.0 4554.6 4603.8 4607.0 4644.1 3642.4 3668.2 3688.2 3704.5 3734.6 1044.7 1073.7 1093.8 1102.3 1105.4 1148.5 1179.6 1214.9 1492.8 1497.9 7899.4 7924.6 8052.8 8059.6 8066.6 683.5 690.4 693.9 696.6 832.3 6162.0 6176.7 6178.2 6180.8 6209.2 9942.2 10264.3 10279.3 10301.4 10328.9 9949.0 10011.2 10068.1 10104.2 10152.9 7507.8 7674.0 7786.3 7815.1 7823.3 7670.2 7671.4 7698.2 7721.1 7735.0 9301.1 9393.7 9479.1 9514.6 9621.9 9066.4 9174.0 9666.1 9674.3 9765.7 7651.1 7843.0 7857.6 7862.6 7880.8 8207.1 8317.1 8338.7 8371.1 8388.8 7516.2 7839.3 7925.8 7952.7 8040.4 7469.7 7666.5 7684.6 7788.3 7803.3 7712.9 7742.4 7771.7 7786.8 7799.0 6864.3 7015.3 7025.9 7032.5 7037.8 7227.1 7276.7 7316.4 7326.9 7329.9 04:54:37 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | [#4] prototype.html Cycles:180 Average:5737.86 Median:6483.35 stddev:1717.27 (26.5%) stddev-sans-first:1674.35 04:54:37 INFO - PROCESS | 12876 | Values: 380.4 381.1 383.2 384.7 385.4 6388.7 6399.6 6440.5 6457.6 6631.8 6406.3 6415.4 6418.0 6436.1 6484.3 4928.5 4955.5 4965.0 4973.7 4978.4 4970.9 4978.5 4986.3 4987.5 4988.9 4575.4 4883.5 4919.1 4923.2 4925.5 4880.3 4888.5 4895.6 4898.4 4908.4 4301.6 4317.1 4318.4 4319.4 4332.9 6083.6 6144.0 6192.3 6216.3 6230.6 5753.3 5754.7 5757.5 5764.1 5766.2 6729.5 6767.2 6789.0 6792.7 6812.6 4718.6 4768.7 4790.0 4804.8 4804.9 6922.2 7119.4 7144.8 7151.0 7174.0 4912.0 4914.8 4927.8 4928.5 4936.6 4981.5 4982.1 4994.8 4995.1 5003.6 5609.4 5670.5 5728.1 5728.2 5745.7 6837.1 6856.2 6870.1 6872.9 6885.5 1722.4 1738.8 1745.8 1753.6 1758.4 1172.5 1183.4 1194.8 1196.3 1215.8 6482.4 6554.6 6565.0 6588.7 6589.9 6954.8 6991.4 7002.6 7007.7 7010.4 6419.4 6480.0 6518.6 6568.5 6572.2 3777.4 3799.0 3802.8 3810.7 3811.5 7129.6 7137.2 7151.6 7170.5 7202.7 7080.9 7101.8 7115.6 7142.1 7338.2 7355.2 7363.2 7365.3 7368.5 7388.1 7109.4 7143.8 7149.2 7155.8 7176.8 6848.5 7014.8 7031.2 7041.7 7049.0 7266.9 7295.0 7327.3 7343.4 7360.4 4934.9 4947.8 4954.4 4974.4 4977.7 6954.0 6965.0 7003.1 7142.6 7144.3 6865.0 6911.4 6913.6 6917.7 6941.8 6920.6 6935.8 6978.7 6979.9 6990.1 6581.7 6652.5 6708.1 6719.6 6748.6 6868.7 6888.3 6889.7 6906.8 6959.1 6788.0 6794.0 6807.3 6838.4 6872.5 04:54:37 INFO - PROCESS | 12876 | 04:54:37 INFO - PROCESS | 12876 | [#5] yui.html Cycles:180 Average:15231.98 Median:24812.86 stddev:17608.84 (71.0%) stddev-sans-first:17625.41 04:54:37 INFO - PROCESS | 12876 | Values: 915.7 918.7 918.8 939.2 953.9 14090.9 14215.1 14251.1 14289.9 15751.7 15728.2 15780.4 15785.0 15803.4 15805.1 871.1 878.1 879.7 888.1 892.3 874.5 882.8 886.1 903.8 909.1 935.1 936.0 938.1 939.7 941.1 923.1 923.5 926.5 927.7 930.6 683.6 685.9 689.1 689.2 690.2 15064.8 15072.1 15199.7 15215.3 15216.5 13976.9 14022.1 14029.0 14183.4 14218.7 11587.6 11925.3 11931.8 12002.9 12032.2 3812.2 3867.6 3894.6 3903.9 3946.7 53603.0 53703.5 54563.7 54666.0 54735.5 10610.7 10952.9 11048.4 11184.5 11420.0 19463.9 19562.4 19570.7 19600.9 19651.7 7936.2 7980.9 8059.8 8144.1 8255.9 4417.4 4483.6 4601.5 4709.7 4818.2 3306.8 3368.4 3373.8 3374.2 3382.0 604.5 604.8 609.1 610.6 627.4 620.2 687.0 687.7 693.5 720.7 8878.3 8947.0 9124.3 9239.7 9327.3 681.8 706.8 712.5 712.7 743.6 4175.3 4261.5 4498.2 4530.0 4544.6 59316.7 61814.0 66008.0 66077.0 66919.7 54953.7 56059.4 56098.0 56203.7 57140.1 49391.0 51105.5 51368.7 51374.7 52258.0 9627.4 9635.1 9811.2 9831.8 10052.2 35971.3 36079.5 36276.0 36723.3 36999.8 45095.8 49800.0 50044.5 50495.7 50841.0 11830.5 11933.0 11949.2 12166.6 12319.0 12514.3 12587.4 13055.0 13254.5 13690.7 12749.4 12899.3 12924.5 13031.2 13190.0 12542.0 12672.9 12715.9 13074.9 13173.3 12219.1 12957.5 13293.0 13304.1 13560.7 9967.0 10151.2 10339.9 10383.4 10452.4 10005.1 10545.3 10615.3 10638.4 10702.5 04:54:37 INFO - PROCESS | 12876 | -------- Summary: end -------- 04:54:37 INFO - PROCESS | 12876 | 04:54:38 INFO - TEST-INFO | 12876: exit 0 04:54:38 INFO - TEST-OK | dromaeo_css | took 1108824ms 04:54:38 INFO - TEST-START | kraken 04:54:38 INFO - operating with platform_type : linux_ 04:54:38 INFO - Initialising browser for kraken test... 04:54:38 INFO - TEST-INFO | started process 13120 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGYbQN3/profile http://localhost:56991/getInfo.html) 04:54:41 INFO - PROCESS | 13120 | 04:54:41 INFO - PROCESS | 13120 | (process:13200): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:54:42 INFO - PROCESS | 13120 | __metrics Screen width/height:1600/1200 04:54:42 INFO - PROCESS | 13120 | colorDepth:24 04:54:42 INFO - PROCESS | 13120 | Browser inner width/height: 1024/697 04:54:42 INFO - PROCESS | 13120 | __metrics 04:54:43 INFO - TEST-INFO | 13120: exit 0 04:54:43 INFO - Browser initialized. 04:54:43 INFO - Running cycle 1/1 for kraken test... 04:54:43 INFO - TEST-INFO | started process 13249 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGYbQN3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:44 INFO - PROCESS | 13249 | 04:54:44 INFO - PROCESS | 13249 | (process:13315): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:54:55 INFO - PROCESS | 13249 | RSS: Main: 141291520 04:54:55 INFO - PROCESS | 13249 | 04:54:57 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56991/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:58 INFO - PROCESS | 13249 | RSS: Main: 146026496 04:54:58 INFO - PROCESS | 13249 | 04:55:01 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56991/tests/kraken/driver.html?testName=audio-dft) 04:55:01 INFO - PROCESS | 13249 | RSS: Main: 145125376 04:55:01 INFO - PROCESS | 13249 | 04:55:04 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56991/tests/kraken/driver.html?testName=audio-fft) 04:55:05 INFO - PROCESS | 13249 | RSS: Main: 146792448 04:55:05 INFO - PROCESS | 13249 | 04:55:07 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56991/tests/kraken/driver.html?testName=audio-oscillator) 04:55:07 INFO - PROCESS | 13249 | RSS: Main: 146812928 04:55:07 INFO - PROCESS | 13249 | 04:55:10 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56991/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:10 INFO - PROCESS | 13249 | RSS: Main: 146714624 04:55:10 INFO - PROCESS | 13249 | 04:55:13 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56991/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:14 INFO - PROCESS | 13249 | RSS: Main: 147075072 04:55:14 INFO - PROCESS | 13249 | 04:55:17 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56991/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:18 INFO - PROCESS | 13249 | RSS: Main: 147591168 04:55:18 INFO - PROCESS | 13249 | 04:55:20 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56991/tests/kraken/driver.html?testName=json-parse-financial) 04:55:21 INFO - PROCESS | 13249 | RSS: Main: 147390464 04:55:21 INFO - PROCESS | 13249 | 04:55:23 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56991/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:23 INFO - PROCESS | 13249 | RSS: Main: 147664896 04:55:23 INFO - PROCESS | 13249 | 04:55:25 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56991/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:26 INFO - PROCESS | 13249 | RSS: Main: 145395712 04:55:26 INFO - PROCESS | 13249 | 04:55:28 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56991/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:28 INFO - PROCESS | 13249 | RSS: Main: 148373504 04:55:28 INFO - PROCESS | 13249 | 04:55:31 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:31 INFO - PROCESS | 13249 | RSS: Main: 145743872 04:55:31 INFO - PROCESS | 13249 | 04:55:34 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:34 INFO - PROCESS | 13249 | RSS: Main: 146563072 04:55:34 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | Cycle 1(1): loaded http://localhost:56991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56991/tests/kraken/driver.html?testName=ai-astar) 04:55:36 INFO - PROCESS | 13249 | RSS: Main: 147226624 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | __start_tp_report 04:55:36 INFO - PROCESS | 13249 | _x_x_mozilla_page_load 04:55:36 INFO - PROCESS | 13249 | _x_x_mozilla_page_load_details 04:55:36 INFO - PROCESS | 13249 | |i|pagename|runs| 04:55:36 INFO - PROCESS | 13249 | |0;ai-astar;113;105;110;111;111;121;110;112;109;110 04:55:36 INFO - PROCESS | 13249 | |1;audio-beat-detection;161;127;161;168;141;154;160;129;161;127 04:55:36 INFO - PROCESS | 13249 | |2;audio-dft;162;162;165;162;162;161;161;161;163;163 04:55:36 INFO - PROCESS | 13249 | |3;audio-fft;77;73;73;146;78;77;76;73;143;75 04:55:36 INFO - PROCESS | 13249 | |4;audio-oscillator;95;96;140;95;95;97;146;96;97;144 04:55:36 INFO - PROCESS | 13249 | |5;imaging-gaussian-blur;110;109;110;111;110;109;110;111;110;111 04:55:36 INFO - PROCESS | 13249 | |6;imaging-darkroom;147;146;147;148;148;147;147;147;146;148 04:55:36 INFO - PROCESS | 13249 | |7;imaging-desaturate;96;97;98;97;97;97;96;96;97;97 04:55:36 INFO - PROCESS | 13249 | |8;json-parse-financial;55;57;56;56;57;57;56;66;55;57 04:55:36 INFO - PROCESS | 13249 | |9;json-stringify-tinderbox;68;65;64;64;65;65;65;65;65;64 04:55:36 INFO - PROCESS | 13249 | |10;stanford-crypto-aes;81;85;82;82;87;88;82;90;81;89 04:55:36 INFO - PROCESS | 13249 | |11;stanford-crypto-ccm;112;110;112;120;114;114;115;111;117;118 04:55:36 INFO - PROCESS | 13249 | |12;stanford-crypto-pbkdf2;139;141;141;146;140;138;132;132;145;144 04:55:36 INFO - PROCESS | 13249 | |13;stanford-crypto-sha256-iterative;66;65;68;70;66;65;68;68;66;66 04:55:36 INFO - PROCESS | 13249 | __end_tp_report 04:55:36 INFO - PROCESS | 13249 | __start_cc_report 04:55:36 INFO - PROCESS | 13249 | _x_x_mozilla_cycle_collect,721 04:55:36 INFO - PROCESS | 13249 | __end_cc_report 04:55:36 INFO - PROCESS | 13249 | __startTimestamp1456318536668__endTimestamp 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | ------- Summary: start ------- 04:55:36 INFO - PROCESS | 13249 | Number of tests: 14 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.05 (3.6%) stddev-sans-first:4.24 04:55:36 INFO - PROCESS | 13249 | Values: 113.0 105.0 110.0 111.0 111.0 121.0 110.0 112.0 109.0 110.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:160.50 stddev:16.23 (10.1%) stddev-sans-first:16.61 04:55:36 INFO - PROCESS | 13249 | Values: 161.0 127.0 161.0 168.0 141.0 154.0 160.0 129.0 161.0 127.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 04:55:36 INFO - PROCESS | 13249 | Values: 162.0 162.0 165.0 162.0 162.0 161.0 161.0 161.0 163.0 163.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.50 stddev:29.26 (38.8%) stddev-sans-first:30.71 04:55:36 INFO - PROCESS | 13249 | Values: 77.0 73.0 73.0 146.0 78.0 77.0 76.0 73.0 143.0 75.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:95.50 stddev:22.99 (24.1%) stddev-sans-first:23.73 04:55:36 INFO - PROCESS | 13249 | Values: 95.0 96.0 140.0 95.0 95.0 97.0 146.0 96.0 97.0 144.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 04:55:36 INFO - PROCESS | 13249 | Values: 110.0 109.0 110.0 111.0 110.0 109.0 110.0 111.0 110.0 111.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:55:36 INFO - PROCESS | 13249 | Values: 147.0 146.0 147.0 148.0 148.0 147.0 147.0 147.0 146.0 148.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 04:55:36 INFO - PROCESS | 13249 | Values: 96.0 97.0 98.0 97.0 97.0 97.0 96.0 96.0 97.0 97.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:3.19 (5.6%) stddev-sans-first:3.28 04:55:36 INFO - PROCESS | 13249 | Values: 55.0 57.0 56.0 56.0 57.0 57.0 56.0 66.0 55.0 57.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.15 (1.8%) stddev-sans-first:0.50 04:55:36 INFO - PROCESS | 13249 | Values: 68.0 65.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:86.00 stddev:3.53 (4.1%) stddev-sans-first:3.48 04:55:36 INFO - PROCESS | 13249 | Values: 81.0 85.0 82.0 82.0 87.0 88.0 82.0 90.0 81.0 89.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:114.50 stddev:3.23 (2.8%) stddev-sans-first:3.32 04:55:36 INFO - PROCESS | 13249 | Values: 112.0 110.0 112.0 120.0 114.0 114.0 115.0 111.0 117.0 118.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:141.00 stddev:4.85 (3.4%) stddev-sans-first:5.13 04:55:36 INFO - PROCESS | 13249 | Values: 139.0 141.0 141.0 146.0 140.0 138.0 132.0 132.0 145.0 144.0 04:55:36 INFO - PROCESS | 13249 | 04:55:36 INFO - PROCESS | 13249 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.69 04:55:36 INFO - PROCESS | 13249 | Values: 66.0 65.0 68.0 70.0 66.0 65.0 68.0 68.0 66.0 66.0 04:55:36 INFO - PROCESS | 13249 | -------- Summary: end -------- 04:55:36 INFO - PROCESS | 13249 | 04:55:37 INFO - TEST-INFO | 13249: exit 0 04:55:37 INFO - TEST-OK | kraken | took 59536ms 04:55:37 INFO - TEST-START | v8_7 04:55:37 INFO - operating with platform_type : linux_ 04:55:37 INFO - Initialising browser for v8_7 test... 04:55:37 INFO - TEST-INFO | started process 13544 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJmNPY1/profile http://localhost:56991/getInfo.html) 04:55:41 INFO - PROCESS | 13544 | 04:55:41 INFO - PROCESS | 13544 | (process:13623): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:55:42 INFO - PROCESS | 13544 | __metrics Screen width/height:1600/1200 04:55:42 INFO - PROCESS | 13544 | colorDepth:24 04:55:42 INFO - PROCESS | 13544 | Browser inner width/height: 1024/697 04:55:42 INFO - PROCESS | 13544 | __metrics 04:55:43 INFO - TEST-INFO | 13544: exit 0 04:55:43 INFO - Browser initialized. 04:55:43 INFO - Running cycle 1/1 for v8_7 test... 04:55:43 INFO - TEST-INFO | started process 13672 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJmNPY1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:44 INFO - PROCESS | 13672 | 04:55:44 INFO - PROCESS | 13672 | (process:13733): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:55:55 INFO - PROCESS | 13672 | RSS: Main: 141262848 04:55:55 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | Cycle 1(1): loaded http://localhost:56991/tests/v8_7/run.html (next: http://localhost:56991/tests/v8_7/run.html) 04:56:17 INFO - PROCESS | 13672 | RSS: Main: 145203200 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | __start_tp_report 04:56:17 INFO - PROCESS | 13672 | _x_x_mozilla_page_load 04:56:17 INFO - PROCESS | 13672 | _x_x_mozilla_page_load_details 04:56:17 INFO - PROCESS | 13672 | |i|pagename|runs| 04:56:17 INFO - PROCESS | 13672 | |0;Richards;167.61649346295675 04:56:17 INFO - PROCESS | 13672 | |1;DeltaBlue;169.63528413910095 04:56:17 INFO - PROCESS | 13672 | |2;Encrypt;278.70680044593087 04:56:17 INFO - PROCESS | 13672 | |3;Decrypt;5186.5284974093265 04:56:17 INFO - PROCESS | 13672 | |4;RayTrace;918.2736455463728 04:56:17 INFO - PROCESS | 13672 | |5;Earley;548.5463521667581 04:56:17 INFO - PROCESS | 13672 | |6;Boyer;11133.333333333334 04:56:17 INFO - PROCESS | 13672 | |7;RegExp;38490.56603773585 04:56:17 INFO - PROCESS | 13672 | |8;Splay;517.063081695967 04:56:17 INFO - PROCESS | 13672 | |9;NavierStokes;4826.923076923077 04:56:17 INFO - PROCESS | 13672 | __end_tp_report 04:56:17 INFO - PROCESS | 13672 | __startTimestamp1456318577701__endTimestamp 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | ------- Summary: start ------- 04:56:17 INFO - PROCESS | 13672 | Number of tests: 10 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 167.6 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#1] DeltaBlue Cycles:1 Average:169.64 Median:169.64 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 169.6 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 278.7 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 5186.5 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#4] RayTrace Cycles:1 Average:918.27 Median:918.27 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 918.3 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#5] Earley Cycles:1 Average:548.55 Median:548.55 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 548.5 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#6] Boyer Cycles:1 Average:11133.33 Median:11133.33 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 11133.3 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#7] RegExp Cycles:1 Average:38490.57 Median:38490.57 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 38490.6 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#8] Splay Cycles:1 Average:517.06 Median:517.06 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 517.1 04:56:17 INFO - PROCESS | 13672 | 04:56:17 INFO - PROCESS | 13672 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:56:17 INFO - PROCESS | 13672 | Values: 4826.9 04:56:17 INFO - PROCESS | 13672 | -------- Summary: end -------- 04:56:17 INFO - PROCESS | 13672 | 04:56:18 INFO - TEST-INFO | 13672: exit 0 04:56:18 INFO - TEST-OK | v8_7 | took 40922ms 04:56:18 INFO - SUITE-END | took 1209s 04:56:18 INFO - Completed test suite (00:20:09) 04:56:18 INFO - Working with test: dromaeo_css 04:56:18 INFO - Generating results file: dromaeo_css 04:56:18 INFO - Working with test: kraken 04:56:18 INFO - Generating results file: kraken 04:56:18 INFO - javascript benchmark 04:56:18 INFO - Working with test: v8_7 04:56:18 INFO - Generating results file: v8_7 04:56:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:56:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 04:56:18 INFO - process_Request line: dromaeo_css 7363.84 graph.html#tests=[[72,52,43]] 04:56:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:56:18 INFO - process_Request line: kraken 1503.30 graph.html#tests=[[232,52,43]] 04:56:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:56:18 INFO - process_Request line: v8_7 22155.10 graph.html#tests=[[230,52,43]] 04:56:18 INFO - RETURN: dromaeo_css: 7363.84 04:56:18 INFO - RETURN: kraken: 1503.30 04:56:18 INFO - RETURN: v8_7: 22155.10 04:56:18 INFO - javascript benchmark 04:56:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3381.188514756458, 3381.5942086949585, 3393.9490907636405, 3418.128377263799, 3422.4010798110326, 5472.699001554918, 5510.752016159272, 5511.338639363277, 5512.669239845602, 5534.861628459291, 5516.834494965157, 5534.501894829465, 5549.861253468665, 5553.250311207986, 5593.272874526316, 5015.796208909854, 5058.317127187819, 5091.745412729368, 5127.692338459704, 5169.663971841837, 4868.853934381974, 5042.445331013604, 5045.34410526631, 5066.518680725325, 5171.948280517185, 5049.3940727112795, 5126.92309615356, 5141.15170996785, 5143.897122057557, 5161.793528258865, 5035.219540971156, 5044.2937988681615, 5049.0406822703935, 5053.722045287508, 5093.185090385539, 4938.950610493885, 4953.405591329064, 4979.601631869478, 4989.251612258154, 4998.500149985009, 4779.593734532569, 5243.554297884684, 5249.737513124367, 5307.0, 5325.4940780625775, 5886.852828679274, 5902.498287645555, 5923.763049478016, 5949.375315591844, 5950.375210602911, 5847.766089356421, 5985.910211346833, 5986.580939334249, 5992.940070599282, 5994.760209591611, 5517.420670829545, 5605.495505404492, 5655.26481557399, 5665.631733937281, 5702.144678298247, 6038.849028774228, 6072.0, 6076.787312444043, 6100.481459076028, 6112.17485639433, 5764.394738552475, 5832.154337621106, 5840.853978650568, 5875.618084824473, 5901.557383196277, 5876.882462350729, 5966.134910437962, 5967.8209653710455, 5975.103734439782, 6011.0, 5813.273340832396, 5841.357450680422, 5892.057270836732, 5916.704164791743, 5954.732037058343, 5762.769489220468, 5829.504492118217, 5890.676012819336, 5897.705114744245, 5903.527717782567, 4460.531644177315, 4497.460304763449, 4505.617022553054, 4563.087382523442, 4584.15193189261, 3993.9016770388375, 4056.411820286042, 4072.2466343726505, 4094.2220978014084, 4094.344904815215, 5521.089020311603, 5529.115341545334, 5609.6353737007785, 5612.186232996192, 5646.124850648156, 5848.9707551462825, 5869.178315035899, 5948.85127871798, 6007.068904319837, 6043.848903777441, 5521.475459831309, 5523.558115350762, 5567.860803479945, 5576.052071147915, 5601.971990140105, 4960.404751429852, 5074.162763144113, 5080.49195080489, 5087.109755792721, 5124.026434977342, 5961.135635332853, 5969.731362088716, 5975.790847320323, 5980.282366116094, 6120.693965301806, 5946.672932988728, 5983.55123365758, 5994.460498555151, 5997.310309314485, 6019.909701354483, 6049.0, 6057.636541807506, 6104.938950610437, 6121.785737499166, 6130.264368275835, 5662.405447428126, 5778.8266352009505, 5800.883982320414, 5802.361740208489, 5903.557233207441, 5894.646321220741, 5928.407159284209, 5942.405759424023, 5946.07835785454, 5954.553408494294, 5722.3991480895575, 5754.0, 5776.451237132465, 5791.160281759037, 5793.91309130355, 5608.579356548356, 5722.599418040697, 5742.339630942495, 5749.367569567261, 5794.101914203306, 5704.286964129484, 5714.771409143587, 5721.914171287351, 5735.8852822944145, 5786.739596718242, 5759.366469688247, 5809.419058094157, 5862.970685146547, 5891.852703682443, 5912.408759124053, 5649.858753531194, 5686.800961966312, 5721.9700453918695, 5748.6838223898085, 5766.077427611562], "unit": "score", "name": "dojo.html", "value": 5458.565406354375}, {"lowerIsBetter": false, "replicates": [548.9094299440595, 557.7713137613578, 567.804107582884, 580.1906340654784, 589.4341432225063, 37605.81197094014, 38517.42223866644, 38809.22381552371, 38810.41784373233, 38839.417408738824, 40872.79563602185, 41626.58373416273, 41680.0, 41842.790786046105, 41852.0, 8816.603252853605, 8873.668949657538, 8944.926608806953, 9030.683926062557, 9038.548072596377, 8745.825083498326, 8880.245179159747, 8884.555772211395, 9055.230305424047, 9092.772680683003, 9035.141661542142, 9132.634694612207, 9176.72469825903, 9182.403143795633, 9188.035256298093, 8917.197452229299, 8984.46093234408, 9056.184943355129, 9070.229030532413, 9072.8639070414, 8809.295256379539, 8855.0, 8903.24322432594, 8919.286457083483, 8930.017698053209, 43076.78461607672, 43343.566564334265, 43622.56377436217, 43661.0, 43699.12601747979, 3372.4772660237704, 3535.7878527288444, 3569.5002699622073, 4079.3269110596716, 4325.221460137174, 32250.0, 32291.19272018195, 32722.509162362585, 33084.834575827204, 33729.15677108092, 4229.577042295777, 4230.7038507304505, 4281.571842815724, 4312.439382880206, 4384.013596940663, 305574.0, 310822.0, 310912.0, 311557.0, 313100.0, 44850.77574612171, 45405.77297113493, 45413.772931135136, 45599.31601025987, 67526.32473675298, 43729.781351093676, 43736.78131609385, 43809.78095109504, 43837.12325753467, 44014.11971760611, 16715.080670563235, 16790.412335568442, 16837.073960932266, 16860.57848553796, 16950.23723932426, 13461.259630720404, 13485.258310792804, 13570.660733481742, 13572.1856688599, 13656.907447404184, 15469.845301547066, 15482.22588870552, 15522.146281954376, 15563.066216027075, 15613.171272483882, 6046.3349031606485, 6145.661988590581, 6178.258608966953, 6224.097505861625, 6242.687865606701, 1009.3388830316155, 1021.7190272674925, 1091.1489038549944, 1158.2413519144973, 1164.9690024328531, 27584.862075689492, 27649.585256221173, 28025.43949121006, 28390.432191356056, 28570.0, 1105.1435137768133, 1127.447550700151, 1151.2171723228118, 1171.701216189866, 1199.2624535910352, 15022.0, 15079.170645614377, 15132.773008404884, 15153.0, 15353.692926141415, 482334.0, 509723.0, 515372.0, 807410.7406240753, 810987.0, 55504.44495555074, 56080.0, 56105.43894561084, 56153.43846561564, 56265.15602265969, 1492.5522343296968, 1502.3990403838334, 1515.3559737111684, 1517.2944580769774, 1518.582389842802, 28725.28186795347, 30029.099127026224, 31913.68086319107, 32278.35443291168, 33094.5035824458, 48914.266286005026, 49512.257316141004, 49621.0, 49659.503404965486, 49957.0, 307594.0, 307822.0, 311630.0, 312348.0, 312502.0, 33533.664663353054, 34764.652353477155, 35001.0, 35099.82450087733, 35121.47317790184, 45745.54254457413, 45924.54075459336, 45999.0, 46567.53432465632, 47224.0, 39202.80398597989, 39253.80373098116, 40210.597894020684, 40237.0, 40813.591864080976, 39800.0, 39940.2011959765, 40598.79700601478, 40647.39028914509, 41319.0, 36709.63290367062, 37443.62556374401, 37516.62483375131, 37626.0, 37759.244815104095, 31820.68179318177, 32041.67958320387, 32589.837050814593, 32591.837040815593, 32761.672383276815, 25055.248342549752, 25559.616605750558, 27068.729312707408, 27355.589666154625, 27359.45281094407], "unit": "score", "name": "ext.html", "value": 19340.43807536536}, {"lowerIsBetter": false, "replicates": [396.3480075276171, 399.76214152579206, 399.9420084087806, 404.23195927737277, 407.088122605364, 14933.551993440187, 15463.69072618547, 17326.0, 17837.64324713505, 17886.10569471526, 10952.780944381107, 11276.154288428359, 16441.753373699376, 18200.27198912045, 18234.0, 4554.863354099374, 5875.823725288248, 5880.26496687914, 5882.411758824126, 5912.142739302799, 5171.146760784485, 5382.4886635769535, 5389.676619402849, 5414.242006119146, 5765.135229715555, 5127.7948882044675, 5214.0, 5246.842594722164, 5408.161734931073, 5416.702081385522, 5462.071447853875, 5469.699166545838, 5507.972460137694, 5512.751926163312, 5753.252077229933, 5614.27014488118, 5616.887662246773, 5618.073017952033, 5636.098224284095, 5734.340550836666, 12689.175203611736, 18976.62046759071, 19142.425727228205, 19603.411897643095, 21486.355409337746, 2171.9782802171935, 2183.1376606240447, 2232.6092933736695, 2271.1710225767474, 2323.1288266899915, 6730.091437655903, 7375.336219740249, 9262.6294948202, 9750.658726944523, 9770.560324785401, 1821.1895706410653, 1899.3162461513843, 1910.1404368034441, 1941.5049162463622, 2033.9084741186682, 60991.69504152495, 62188.37811621871, 63535.68232158856, 63922.68038659824, 65080.0, 10775.892241077645, 11021.724456888642, 11046.668599942015, 11085.27945683528, 11099.944500277446, 14716.043457175248, 14775.92612036933, 14778.556643300719, 14813.185274809988, 14861.479848205261, 8571.314294856396, 8579.056303806576, 8619.310455163697, 8662.826743465095, 8678.609462574073, 8427.452215606088, 8464.492130472192, 8482.872756908651, 8519.105493923173, 8565.10066443027, 4722.079194557097, 4814.807407703653, 7712.537247765152, 8021.27808497238, 8025.197480252044, 3138.9686103139134, 3182.6791881369436, 3235.5955505561806, 3266.4936934774673, 3283.7865538739907, 941.5010044676333, 999.0908273471251, 1056.5562463765236, 1066.594694016269, 1085.5277954089995, 17147.056911869968, 17422.738658920127, 17638.647227055386, 17702.734458983126, 18267.177976991068, 1013.2805707947292, 1035.0942924940678, 1045.3727763341933, 1050.826613608746, 1152.2280072351546, 9401.388909720983, 9511.524423778783, 9553.0, 9579.233661307078, 9758.219342452587, 425039.0, 430280.0, 431209.0, 435114.0, 642924.0, 78898.0, 78967.60516197383, 80353.19646803457, 80502.59748701219, 83403.5829820847, 1244.807054906491, 1249.8562665293607, 1253.6677780388204, 1272.5927703135094, 1298.026480139895, 15872.682546349239, 15889.443869464514, 16003.0, 16119.597010074373, 16234.350625974828, 33149.834250829554, 33949.0, 34256.143596410286, 34912.0, 36029.63970360368, 43592.34611480894, 44466.333005005596, 45247.321290180014, 46318.53681463142, 46493.76753116213, 7565.6973721050545, 7692.538447693157, 7710.306072453506, 8217.05503867039, 8319.417640765088, 9238.630454781733, 12004.879951200377, 12021.879781202077, 12314.384280785745, 12331.260124392205, 3332.6167490738876, 3335.8832440864453, 3942.64516193544, 8516.740195956092, 11148.989772761472, 10688.89311106879, 10905.400202988594, 11185.66443006711, 11267.549298027987, 11287.7742445149, 11073.889261107286, 11331.150163737588, 11375.43122843838, 11411.828822567502, 11586.246893951866, 7723.729669461542, 7794.181610930771, 7952.363810894999, 7999.240072193133, 8059.637316320663, 10574.735631609272, 11030.613928512463, 11145.0, 11222.326660400402, 11227.0], "unit": "score", "name": "jquery.html", "value": 8728.519783093}, {"lowerIsBetter": false, "replicates": [1581.0829718763118, 1606.1407147176262, 1851.93518226862, 1916.4633902507303, 1958.5495336072704, 8405.453645513036, 8509.106543812903, 8631.093735157812, 8653.913460865397, 8685.47887126773, 8705.564721763902, 8710.782230444227, 8757.299416046717, 8821.603027863746, 8831.0, 2383.833131680783, 2393.1504315967886, 2401.987990060047, 2403.7836594706473, 2405.20628192696, 2373.145667559686, 2428.0, 2436.8050555955483, 2439.2682195341417, 2446.388402899275, 2368.348704106367, 2414.0343862454984, 2422.2975337152207, 2431.294924471901, 2437.6587277781123, 2369.158948573249, 2416.6012607919674, 2427.6844010278637, 2444.9022039118504, 2445.254197469771, 2377.7741114594087, 2407.41018450479, 2407.8675672837985, 2412.0110754590532, 2421.6004359280696, 8188.385871059694, 8197.877031844528, 8266.380021498411, 8270.172982701743, 8294.253517183422, 5032.4967503249745, 5056.949430505685, 5117.2068329409, 5146.356705411824, 5166.61250406221, 3239.7894136881264, 3254.625718042432, 3275.459549174407, 3298.736101111905, 3311.6522765109557, 1170.9648710538697, 1175.1304035014027, 1200.1658847101269, 1205.843240378754, 1218.6831423829778, 11802.586909458129, 11872.10959178065, 11921.642350729491, 11942.044636429151, 12021.879781202164, 4317.179735850241, 4326.956730432656, 4365.694401391872, 4384.254676704904, 4413.514513403523, 9692.903070969342, 9707.757306067264, 9712.22302215821, 9812.62623232748, 9814.263930205121, 4955.35580374549, 4973.726445045485, 5020.974895125501, 5021.472745361758, 5037.471065538139, 4539.977300113478, 4554.63562914966, 4603.769811509411, 4607.0, 4644.094401591725, 3642.4354225095153, 3668.2296717689583, 3688.1517251032415, 3704.518412606344, 3734.6452087051684, 1044.6761503933806, 1073.6725298783947, 1093.775775965925, 1102.3330884814732, 1105.4307031878589, 1148.542119863476, 1179.6461061681632, 1214.9028077753758, 1492.8283247426468, 1497.9026363286569, 7899.447038707235, 7924.6037698116015, 8052.758417247492, 8059.597020149086, 8066.556339401389, 683.5147045597681, 690.3579670906106, 693.8785712500293, 696.5681277607915, 832.3341326938425, 6162.044883043135, 6176.722047507783, 6178.165947597106, 6180.81457556274, 6209.192804935329, 9942.154916832005, 10264.332818366782, 10279.331843430153, 10301.433421161908, 10328.896711032794, 9949.0, 10011.199104071657, 10068.144207742424, 10104.242181836391, 10152.949235253776, 7507.812304692317, 7673.961630191925, 7786.338161256356, 7815.062192537046, 7823.295903368724, 7670.156282808775, 7671.38628909697, 7698.230176982481, 7721.073471183494, 7735.0, 9301.116393942564, 9393.671221507488, 9479.146876781122, 9514.571844267162, 9621.855672165064, 9066.36535442539, 9174.0, 9666.130048295687, 9674.274429417681, 9765.707028789147, 7651.120121186135, 7843.0, 7857.646405911862, 7862.60686965638, 7880.802979925318, 8207.097219305751, 8317.085120636604, 8338.708145214889, 8371.121032291521, 8388.790280243044, 7516.210797866364, 7839.25527074927, 7925.841483170419, 7952.721654742057, 8040.356771458152, 7469.701211951461, 7666.540007599562, 7684.6157692116285, 7788.260115289038, 7803.297703206738, 7712.884306735516, 7742.38060955111, 7771.650275737718, 7786.805329866798, 7798.961005194938, 6864.347886950732, 7015.298470152944, 7025.894611580932, 7032.542884712478, 7037.7888663338135, 7227.060482137288, 7276.745313913988, 7316.414686825147, 7326.853462930605, 7329.853402931805], "unit": "score", "name": "mootools.html", "value": 4799.291699903016}, {"lowerIsBetter": false, "replicates": [380.36099353086814, 381.12341614287135, 383.2067620026546, 384.7345331721114, 385.39685392360946, 6388.744450221986, 6399.616023038621, 6440.516961227903, 6457.6448295343735, 6631.767888123916, 6406.295307516181, 6415.422611964922, 6418.037294405842, 6436.098946147543, 6484.319146489622, 4928.457869634337, 4955.479674634165, 4965.031818795336, 4973.701577905319, 4978.377702787152, 4970.87572810679, 4978.477259887714, 4986.252062190664, 4987.476314986929, 4988.877502561931, 4575.359449677047, 4883.487233840431, 4919.089968355847, 4923.18767403378, 4925.458199598042, 4880.316755654211, 4888.535589119028, 4895.5838753705975, 4898.436679781835, 4908.361912951329, 4301.5698430156735, 4317.050248945227, 4318.4170137031415, 4319.352097185416, 4332.891677708051, 6083.6045657032155, 6144.0, 6192.349803270637, 6216.254049514042, 6230.626162430223, 5753.338366087912, 5754.654720716729, 5757.539396848242, 5764.135379693038, 5766.221560089376, 6729.49528785343, 6767.1879374475375, 6788.9660551696925, 6792.66036698168, 6812.557183783038, 4718.551737584924, 4768.690035147704, 4789.976050119727, 4804.831830885937, 4804.927926081112, 6922.169339679221, 7119.430445564394, 7144.821379465555, 7151.0, 7174.0, 4911.950880491221, 4914.778834952435, 4927.77824997876, 4928.457869634337, 4936.6297527685565, 4981.476944920803, 4982.078315511642, 4994.80020799164, 4995.125852975715, 5003.574696150795, 5609.411011843697, 5670.461306175906, 5728.112142617901, 5728.169415434739, 5745.683987380734, 6837.111175547247, 6856.24581296057, 6870.072540207008, 6872.896906546406, 6885.483588730865, 1722.431597572798, 1738.782652168479, 1745.825417458244, 1753.587906841891, 1758.358199257262, 1172.5427083437467, 1183.360985068071, 1194.808830587102, 1196.2882085159317, 1215.8480189976253, 6482.384173503509, 6554.639494827735, 6565.0, 6588.703508342136, 6589.868202636017, 6954.756583519553, 6991.44068474531, 7002.579845209202, 7007.719691212396, 7010.369066784014, 6419.422251997343, 6480.0, 6518.57629254097, 6568.507361947873, 6572.178477690289, 3777.3578491656485, 3799.0122568131933, 3802.771833689932, 3810.657040866335, 3811.504504414464, 7129.572225666477, 7137.2149063602965, 7151.606661633556, 7170.533915295489, 7202.675879585431, 7080.893786593102, 7101.751438699621, 7115.6086415247655, 7142.071530700976, 7338.22948590401, 7355.190928997806, 7363.15323737777, 7365.274848306054, 7368.4842061055215, 7388.076490438695, 7109.360157585842, 7143.82140446493, 7149.177844547944, 7155.785326440215, 7176.7846964591145, 6848.520603557703, 7014.824629384306, 7031.226565077735, 7041.718331266692, 7048.964755176191, 7266.854662906607, 7294.96352518234, 7327.303906128909, 7343.44924130703, 7360.374368178765, 4934.851954441229, 4947.752612369439, 4954.430240522242, 4974.403071631427, 4977.651564390458, 6953.965230173817, 6964.9900764389895, 7003.089598352181, 7142.607156606437, 7144.285571442814, 6865.0, 6911.3779759819845, 6913.5506192097355, 6917.654117294216, 6941.791746247621, 6920.550164239308, 6935.791926242221, 6978.70893884633, 6979.930200697928, 6990.126234220723, 6581.703823327866, 6652.501062420241, 6708.060871477899, 6719.596824190564, 6748.628825414649, 6868.690908909011, 6888.276730943179, 6889.724411023503, 6906.758263460755, 6959.060526828814, 6787.966060169668, 6793.98090286461, 6807.285235050248, 6838.350356716104, 6872.450203983769], "unit": "score", "name": "prototype.html", "value": 5187.196154940091}, {"lowerIsBetter": false, "replicates": [915.6932427636741, 918.6692790595384, 918.8208299381619, 939.2204470289661, 953.9236861051116, 14090.859091409096, 14215.147091174536, 14251.144931304103, 14289.928550357246, 15751.684966300667, 15728.213589320545, 15780.368785248576, 15785.0, 15803.367865285374, 15805.051696898194, 871.1245198575455, 878.0911756332198, 879.683314006957, 888.0985799413601, 892.2772554231094, 874.4971641306242, 882.8455020371441, 886.1404437695458, 903.7695387676133, 909.0545832334365, 935.1116439382614, 935.9859602105973, 938.1228551304519, 939.736873675372, 941.1106504353389, 923.1368670293264, 923.5382308845577, 926.4580220570974, 927.7263207353847, 930.5951910918739, 683.596677960001, 685.8971154326841, 689.1282527602586, 689.2039694153211, 690.2166041542835, 15064.774028389584, 15072.095674259579, 15199.696006079927, 15215.315310810929, 15216.543503694907, 13976.93011534946, 14022.088564243393, 14029.0, 14183.43266269348, 14218.715625687428, 11587.594434194763, 11925.284482931052, 11931.761364772656, 12002.890821641342, 12032.157748957576, 3812.1803812180237, 3867.5939026402384, 3894.610538946111, 3903.902402439933, 3946.7039972001926, 53603.0, 53703.462965370236, 54563.72718136424, 54665.99337036501, 54735.45264547344, 10610.681679549625, 10952.945235273932, 11048.392338421463, 11184.496697648625, 11420.0, 19463.902680486506, 19562.413127606196, 19570.70643940342, 19600.90199548993, 19651.72263802848, 7936.246056624727, 7980.920190798134, 8059.83880322402, 8144.104148543655, 8255.917440825635, 4417.3815665806815, 4483.596476317147, 4601.493835678073, 4709.693869898446, 4818.229083346648, 3306.834658267077, 3368.4105281575626, 3373.8313084345687, 3374.1901943533376, 3382.0, 604.4861867412752, 604.8366940925926, 609.1319869186392, 610.5603965145089, 627.4290395739855, 620.1937481274325, 687.028972538727, 687.656171914043, 693.4591019005184, 720.7441358317826, 8878.334124940655, 8946.955265223762, 9124.315676324302, 9239.676611318571, 9327.347085703936, 681.8295426143465, 706.7667669668997, 712.5048091576305, 712.682856129028, 743.6356185469081, 4175.290200665894, 4261.509926358446, 4498.190325741398, 4529.9547004530195, 4544.613707834871, 59316.70341648264, 61814.0, 66008.0, 66077.0, 66919.66540167268, 54953.72523137359, 56059.43940560624, 56098.0, 56203.71898140483, 57140.14289785657, 49391.0121797562, 51105.48894511082, 51368.74315628398, 51374.74312628413, 52258.0, 9627.422354658744, 9635.13283804461, 9811.215102791617, 9831.754206144904, 10052.246081543768, 35971.28057438784, 36079.45880811737, 36276.0, 36723.265534688624, 36999.81500092482, 45095.77452112718, 49800.0, 50044.49955500398, 50495.74752126216, 50841.0, 11830.46762895689, 11933.0, 11949.21954639703, 12166.635000949986, 12319.0, 12514.31171285588, 12587.433565489759, 13055.0, 13254.53609123676, 13690.65773355674, 12749.362531873183, 12899.290539020069, 12924.483020679067, 13031.218126912416, 13190.0, 12542.0, 12672.87327126717, 12715.93642031784, 13074.869251307366, 13173.341332933507, 12219.144659874079, 12957.481700731865, 13293.0, 13304.068715189844, 13560.728785424433, 9966.950165249127, 10151.238657100896, 10339.896601034194, 10383.428911409945, 10452.372857628263, 10005.078720162495, 10545.31455455393, 10615.256932014685, 10638.41488718128, 10702.518386672462], "unit": "score", "name": "yui.html", "value": 6950.147073972381}], "name": "dromaeo_css", "value": 7363.833738533227}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 110.0, 111.0, 111.0, 121.0, 110.0, 112.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [161.0, 127.0, 161.0, 168.0, 141.0, 154.0, 160.0, 129.0, 161.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 165.0, 162.0, 162.0, 161.0, 161.0, 161.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 73.0, 146.0, 78.0, 77.0, 76.0, 73.0, 143.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 140.0, 95.0, 95.0, 97.0, 146.0, 96.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 110.0, 109.0, 110.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 56.0, 56.0, 57.0, 57.0, 56.0, 66.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 82.0, 82.0, 87.0, 88.0, 82.0, 90.0, 81.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 112.0, 120.0, 114.0, 114.0, 115.0, 111.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.3}, {"lowerIsBetter": true, "replicates": [139.0, 141.0, 141.0, 146.0, 140.0, 138.0, 132.0, 132.0, 145.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 68.0, 70.0, 66.0, 65.0, 68.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1503.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [169.63528413910095], "unit": "score", "name": "DeltaBlue", "value": 389.76561000000004}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [918.2736455463728], "unit": "score", "name": "RayTrace", "value": 805.8480209999998}, {"lowerIsBetter": false, "replicates": [548.5463521667581], "unit": "score", "name": "Earley", "value": 1214.9620489999998}, {"lowerIsBetter": false, "replicates": [11133.333333333334], "unit": "score", "name": "Boyer", "value": 59.86194610778439}, {"lowerIsBetter": false, "replicates": [38490.56603773585], "unit": "score", "name": "RegExp", "value": 23.667747549019616}, {"lowerIsBetter": false, "replicates": [517.063081695967], "unit": "score", "name": "Splay", "value": 157.6035939999999}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22155.098038131193}]} 04:56:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22155.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1503.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7363.84"}}} 04:56:18 INFO - Return code: 0 04:56:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:56:18 INFO - # TBPL SUCCESS # 04:56:18 INFO - Running post-action listener: _resource_record_post_action 04:56:18 INFO - Running post-run listener: _resource_record_post_run 04:56:20 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 77824; Write bytes: 513572864; Read time: 288; Write time: 340344 04:56:20 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248463360; Read time: 140; Write time: 208296 04:56:20 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 73728; Write bytes: 265109504; Read time: 148; Write time: 132048 04:56:20 INFO - Running post-run listener: _upload_blobber_files 04:56:20 INFO - Blob upload gear active. 04:56:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:56:20 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:56:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:56:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:56:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:56:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:56:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:21 INFO - (blobuploader) - INFO - Done attempting. 04:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:22 INFO - (blobuploader) - INFO - Done attempting. 04:56:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:22 INFO - Return code: 0 04:56:22 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:56:22 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/015e5468a698b33c9a4f5cadf7d49e56ec6f49cfdec5a0e3f22288f70d1b82afc3136ac7b74d70e9217b53b2bb26b17ca0795a5d0206af5f44890a1bae987101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3b9089bb9e86a36dab274f2e44a949bb88796321426ddc39e1e59ece8f3ef90dcd0ec9df44617da559cf451fe98bc11f62fdf463afab34ffbd7c04ecbc96b1c"} 04:56:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:56:22 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:56:22 INFO - Contents: 04:56:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/015e5468a698b33c9a4f5cadf7d49e56ec6f49cfdec5a0e3f22288f70d1b82afc3136ac7b74d70e9217b53b2bb26b17ca0795a5d0206af5f44890a1bae987101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3b9089bb9e86a36dab274f2e44a949bb88796321426ddc39e1e59ece8f3ef90dcd0ec9df44617da559cf451fe98bc11f62fdf463afab34ffbd7c04ecbc96b1c"} 04:56:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:22 INFO - Copying logs to upload dir... 04:56:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:56:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.540808 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-24 04:56:22.706986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 04:56:22.710088) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 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/Mozilla-Aurora/sha512/015e5468a698b33c9a4f5cadf7d49e56ec6f49cfdec5a0e3f22288f70d1b82afc3136ac7b74d70e9217b53b2bb26b17ca0795a5d0206af5f44890a1bae987101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3b9089bb9e86a36dab274f2e44a949bb88796321426ddc39e1e59ece8f3ef90dcd0ec9df44617da559cf451fe98bc11f62fdf463afab34ffbd7c04ecbc96b1c"} build_url:https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/LazbNqJnQ8WorG00h3BRBA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/015e5468a698b33c9a4f5cadf7d49e56ec6f49cfdec5a0e3f22288f70d1b82afc3136ac7b74d70e9217b53b2bb26b17ca0795a5d0206af5f44890a1bae987101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3b9089bb9e86a36dab274f2e44a949bb88796321426ddc39e1e59ece8f3ef90dcd0ec9df44617da559cf451fe98bc11f62fdf463afab34ffbd7c04ecbc96b1c"}' ========= master_lag: 0.37 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 04:56:23.096295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:56:23.096615) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1456317315.925372-997565537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:56:23.116811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 04:56:23.117130) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 04:56:23.117422) ========= ========= Total master_lag: 1.21 =========