builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1478091644.24 results: success (0) buildid: 20161102030205 builduid: 0633e01a4a3c490b9155adba5e06037c revision: 3e73fd638e687a4d7f46613586e5156b8e2af846 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.240393) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.240914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.241208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.257024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.257429) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-02 06:00:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-11-02 06:00:44 (38.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.354731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.355050) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017686 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.408581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:44.409098) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e73fd638e687a4d7f46613586e5156b8e2af846 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3e73fd638e687a4d7f46613586e5156b8e2af846 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-02 06:00:44,658 truncating revision to first 12 chars 2016-11-02 06:00:44,659 Setting DEBUG logging. 2016-11-02 06:00:44,659 attempt 1/10 2016-11-02 06:00:44,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e73fd638e68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 06:00:44,983 unpacking tar archive at: mozilla-central-3e73fd638e68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:45.062283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:45.062607) ========= script_repo_revision: 3e73fd638e687a4d7f46613586e5156b8e2af846 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:45.062999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:45.063285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 06:00:45.073631) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-02 06:00:45.074019) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:45 INFO - MultiFileLogger online at 20161102 06:00:45 in /builds/slave/test 06:00:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:00:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:45 INFO - {'append_to_log': False, 06:00:45 INFO - 'base_work_dir': '/builds/slave/test', 06:00:45 INFO - 'blob_upload_branch': 'Firefox', 06:00:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:45 INFO - 'branch': 'Firefox', 06:00:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:45 INFO - 'config_files': ('talos/linux_config.py',), 06:00:45 INFO - 'default_actions': ('clobber', 06:00:45 INFO - 'read-buildbot-config', 06:00:45 INFO - 'download-and-extract', 06:00:45 INFO - 'populate-webroot', 06:00:45 INFO - 'create-virtualenv', 06:00:45 INFO - 'install', 06:00:45 INFO - 'run-tests'), 06:00:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:45 INFO - 'download_minidump_stackwalk': True, 06:00:45 INFO - 'download_symbols': 'ondemand', 06:00:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:45 INFO - 'installer_path': 'installer.exe', 06:00:45 INFO - 'log_level': 'info', 06:00:45 INFO - 'log_name': 'talos', 06:00:45 INFO - 'log_to_console': True, 06:00:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:45 INFO - 'opt_config_files': (), 06:00:45 INFO - 'pip_index': False, 06:00:45 INFO - 'sps_profile': False, 06:00:45 INFO - 'sps_profile_interval': 0, 06:00:45 INFO - 'suite': 'dromaeojs', 06:00:45 INFO - 'system_bits': '32', 06:00:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:45 INFO - 'title': 'talos-linux64-ix-036', 06:00:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:45 INFO - 'use_talos_json': True, 06:00:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:45 INFO - 'work_dir': 'build'} 06:00:45 INFO - [mozharness: 2016-11-02 13:00:45.420755Z] Running clobber step. 06:00:45 INFO - Running pre-action listener: _resource_record_pre_action 06:00:45 INFO - Running main action method: clobber 06:00:45 INFO - rmtree: /builds/slave/test/build 06:00:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:00:45 INFO - Running post-action listener: _resource_record_post_action 06:00:45 INFO - [mozharness: 2016-11-02 13:00:45.914575Z] Finished clobber step (success) 06:00:45 INFO - [mozharness: 2016-11-02 13:00:45.914675Z] Running read-buildbot-config step. 06:00:45 INFO - Running pre-action listener: _resource_record_pre_action 06:00:45 INFO - Running main action method: read_buildbot_config 06:00:45 INFO - Using buildbot properties: 06:00:45 INFO - { 06:00:45 INFO - "project": "", 06:00:45 INFO - "product": "firefox", 06:00:45 INFO - "script_repo_revision": "production", 06:00:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:00:45 INFO - "repository": "", 06:00:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:00:45 INFO - "buildid": "20161102030205", 06:00:45 INFO - "stage_platform": "linux64-pgo", 06:00:45 INFO - "basedir": "/builds/slave/test", 06:00:45 INFO - "nightly_build": "True", 06:00:45 INFO - "buildnumber": 52, 06:00:45 INFO - "slavename": "talos-linux64-ix-036", 06:00:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:00:45 INFO - "platform": "ubuntu64_hw", 06:00:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:00:45 INFO - "branch": "mozilla-central", 06:00:45 INFO - "repo_path": "mozilla-central", 06:00:45 INFO - "revision": "3e73fd638e687a4d7f46613586e5156b8e2af846", 06:00:45 INFO - "pgo_build": "True", 06:00:45 INFO - "builduid": "0633e01a4a3c490b9155adba5e06037c", 06:00:45 INFO - "slavebuilddir": "test" 06:00:45 INFO - } 06:00:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:00:45 INFO - Running post-action listener: _resource_record_post_action 06:00:45 INFO - [mozharness: 2016-11-02 13:00:45.917209Z] Finished read-buildbot-config step (success) 06:00:45 INFO - [mozharness: 2016-11-02 13:00:45.917298Z] Running download-and-extract step. 06:00:45 INFO - Running pre-action listener: _resource_record_pre_action 06:00:45 INFO - Running main action method: download_and_extract 06:00:45 INFO - mkdir: /builds/slave/test/build/tests 06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:45 INFO - trying https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:00:45 INFO - Downloading https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:00:46 INFO - Downloaded 1361 bytes. 06:00:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:00:46 INFO - Using the following test package requirements: 06:00:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:00:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:00:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:46 INFO - u'jsshell-linux-x86_64.zip'], 06:00:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:00:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:00:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:00:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:00:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:00:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:00:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:00:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:46 INFO - Fetch https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:00:47 INFO - Http code: 200 06:00:47 INFO - via: 1.1 3344ddc09ccf1d185bb41add18940cc4.cloudfront.net (CloudFront) 06:00:47 INFO - x-amz-cf-id: y6pIWzXleWseB_g50Fnz3oW5wph9FDPxvFNyXHe1PgWbSwxdJQSo2Q== 06:00:47 INFO - x-amz-version-id: DhGf.h6MPhFzq8.Mrnng_yp1_ARyFIVZ 06:00:47 INFO - Expected file size: 22019408 06:00:47 INFO - Obtained file size: 22019408 06:00:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:00:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:00:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:51 INFO - Fetch https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:00:52 INFO - Http code: 200 06:00:52 INFO - via: 1.1 515297ac55a7ae01bf8c7d03df4fecb1.cloudfront.net (CloudFront) 06:00:52 INFO - x-amz-cf-id: tK5QiYTrIv5zYNwTEcUos-2XF-DFiQoAfudhWERoqa2MabFP2xiMYw== 06:00:52 INFO - x-amz-version-id: DhGf.h6MPhFzq8.Mrnng_yp1_ARyFIVZ 06:00:52 INFO - Expected file size: 22019408 06:00:52 INFO - Obtained file size: 22019408 06:00:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:00:56 INFO - Fetch https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:00:57 INFO - Http code: 200 06:00:57 INFO - via: 1.1 1c6cc78b8ca6319854350cf7a741a470.cloudfront.net (CloudFront) 06:00:57 INFO - x-amz-cf-id: PtSfw9QW1TaiG6lA1yTwlMhAKqeUEBx6EmtESbTr_tDgrOVePRBBnw== 06:00:57 INFO - x-amz-version-id: w_vX1GXP6kjvwxwVraDV3vhFh9ZxrAeQ 06:00:57 INFO - Expected file size: 14409038 06:00:57 INFO - Obtained file size: 14409038 06:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:57 INFO - trying https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:00:57 INFO - Downloading https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:00:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:00:58 INFO - Downloaded 59603144 bytes. 06:00:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:00:58 INFO - mkdir: /builds/slave/test/properties 06:00:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:58 INFO - Contents: 06:00:58 INFO - build_url:https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:00:59 INFO - Running post-action listener: _resource_record_post_action 06:00:59 INFO - Running post-action listener: set_extra_try_arguments 06:00:59 INFO - [mozharness: 2016-11-02 13:00:59.504102Z] Finished download-and-extract step (success) 06:00:59 INFO - [mozharness: 2016-11-02 13:00:59.504330Z] Running populate-webroot step. 06:00:59 INFO - Running pre-action listener: _resource_record_pre_action 06:00:59 INFO - Running main action method: populate_webroot 06:00:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:59 INFO - '--tppagecycles', 06:00:59 INFO - '7'], 06:00:59 INFO - 'tests': ['tsvgm']}}, 06:00:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:00:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:00:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:00:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['damp', 'tps']}, 06:00:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'tests': ['damp', 'tps']}, 06:00:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['dromaeo_dom']}, 06:00:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['basic_compositor_video']}, 06:00:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:00:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other-e10s': {'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['a11yr', 06:00:59 INFO - 'ts_paint', 06:00:59 INFO - 'tpaint', 06:00:59 INFO - 'sessionrestore', 06:00:59 INFO - 'sessionrestore_no_auto_restore', 06:00:59 INFO - 'tabpaint']}, 06:00:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['tsvgx', 06:00:59 INFO - 'tsvgr_opacity', 06:00:59 INFO - 'tart', 06:00:59 INFO - 'tscrollx', 06:00:59 INFO - 'cart']}, 06:00:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:00:59 INFO - 'tsvgr_opacity', 06:00:59 INFO - 'tart', 06:00:59 INFO - 'tscrollx', 06:00:59 INFO - 'cart']}, 06:00:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--disable-e10s'], 06:00:59 INFO - 'tests': ['tp5o']}, 06:00:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'tests': ['tp5o']}, 06:00:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--disable-e10s', 06:00:59 INFO - '--xperf_path', 06:00:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:59 INFO - 'tests': ['tp5n']}, 06:00:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:59 INFO - 'talos_options': ['--xperf_path', 06:00:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:59 INFO - 'tests': ['tp5n']}}, 06:00:59 INFO - 'talos.zip': {'path': '', 06:00:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:59 INFO - Running post-action listener: _resource_record_post_action 06:00:59 INFO - [mozharness: 2016-11-02 13:00:59.525689Z] Finished populate-webroot step (success) 06:00:59 INFO - [mozharness: 2016-11-02 13:00:59.525790Z] Running create-virtualenv step. 06:00:59 INFO - Running pre-action listener: _resource_record_pre_action 06:00:59 INFO - Running main action method: create_virtualenv 06:00:59 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:00:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:59 INFO - Using real prefix '/usr' 06:00:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:01:00 INFO - Installing distribute.............................................................................................................................................................................................done. 06:01:02 INFO - Installing pip.................done. 06:01:02 INFO - Return code: 0 06:01:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:01:02 INFO - Reading from file tmpfile_stdout 06:01:02 INFO - Output received: 06:01:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:01:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:02 INFO - Running command: ['/builds/slave/test/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/build 06:01:02 INFO - Copy/paste: /builds/slave/test/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 06:01:02 INFO - Using env: {'DISPLAY': ':0', 06:01:02 INFO - 'HOME': '/home/cltbld', 06:01:02 INFO - 'LANG': 'en_US.UTF-8', 06:01:02 INFO - 'LANGUAGE': 'en_US:en', 06:01:02 INFO - 'LOGNAME': 'cltbld', 06:01:02 INFO - 'MAIL': '/var/mail/cltbld', 06:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:02 INFO - 'MOZ_NO_REMOTE': '1', 06:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:02 INFO - 'NO_EM_RESTART': '1', 06:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:02 INFO - 'PWD': '/builds/slave/test', 06:01:02 INFO - 'SHELL': '/bin/bash', 06:01:02 INFO - 'SHLVL': '1', 06:01:02 INFO - 'TERM': 'linux', 06:01:02 INFO - 'TMOUT': '86400', 06:01:02 INFO - 'USER': 'cltbld', 06:01:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:02 INFO - '_': '/tools/buildbot/bin/python'} 06:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:02 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 06:01:02 INFO - Cleaning up... 06:01:02 INFO - Return code: 0 06:01:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:02 INFO - Running command: ['/builds/slave/test/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>=3.1.1'] in /builds/slave/test/build 06:01:02 INFO - Copy/paste: /builds/slave/test/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>=3.1.1 06:01:02 INFO - Using env: {'DISPLAY': ':0', 06:01:02 INFO - 'HOME': '/home/cltbld', 06:01:02 INFO - 'LANG': 'en_US.UTF-8', 06:01:02 INFO - 'LANGUAGE': 'en_US:en', 06:01:02 INFO - 'LOGNAME': 'cltbld', 06:01:02 INFO - 'MAIL': '/var/mail/cltbld', 06:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:02 INFO - 'MOZ_NO_REMOTE': '1', 06:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:02 INFO - 'NO_EM_RESTART': '1', 06:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:02 INFO - 'PWD': '/builds/slave/test', 06:01:02 INFO - 'SHELL': '/bin/bash', 06:01:02 INFO - 'SHLVL': '1', 06:01:02 INFO - 'TERM': 'linux', 06:01:02 INFO - 'TMOUT': '86400', 06:01:02 INFO - 'USER': 'cltbld', 06:01:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:02 INFO - '_': '/tools/buildbot/bin/python'} 06:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:02 INFO - Downloading/unpacking psutil>=3.1.1 06:01:02 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 06:01:02 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 06:01:02 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 06:01:02 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 06:01:02 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 06:01:02 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 06:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:01:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:04 INFO - Installing collected packages: psutil 06:01:04 INFO - Running setup.py install for psutil 06:01:04 INFO - building 'psutil._psutil_linux' extension 06:01:04 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 06:01:05 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 06:01:05 INFO - building 'psutil._psutil_posix' extension 06:01:05 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 06:01:05 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 06:01:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:05 INFO - Successfully installed psutil 06:01:05 INFO - Cleaning up... 06:01:05 INFO - Return code: 0 06:01:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:05 INFO - Running command: ['/builds/slave/test/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.3'] in /builds/slave/test/build 06:01:05 INFO - Copy/paste: /builds/slave/test/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.3 06:01:05 INFO - Using env: {'DISPLAY': ':0', 06:01:05 INFO - 'HOME': '/home/cltbld', 06:01:05 INFO - 'LANG': 'en_US.UTF-8', 06:01:05 INFO - 'LANGUAGE': 'en_US:en', 06:01:05 INFO - 'LOGNAME': 'cltbld', 06:01:05 INFO - 'MAIL': '/var/mail/cltbld', 06:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:05 INFO - 'MOZ_NO_REMOTE': '1', 06:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:05 INFO - 'NO_EM_RESTART': '1', 06:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:05 INFO - 'PWD': '/builds/slave/test', 06:01:05 INFO - 'SHELL': '/bin/bash', 06:01:05 INFO - 'SHLVL': '1', 06:01:05 INFO - 'TERM': 'linux', 06:01:05 INFO - 'TMOUT': '86400', 06:01:05 INFO - 'USER': 'cltbld', 06:01:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:05 INFO - '_': '/tools/buildbot/bin/python'} 06:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:01:07 INFO - Installing collected packages: mozsystemmonitor 06:01:07 INFO - Running setup.py install for mozsystemmonitor 06:01:07 INFO - Successfully installed mozsystemmonitor 06:01:07 INFO - Cleaning up... 06:01:07 INFO - Return code: 0 06:01:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:07 INFO - Running command: ['/builds/slave/test/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==2.5.1'] in /builds/slave/test/build 06:01:07 INFO - Copy/paste: /builds/slave/test/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==2.5.1 06:01:07 INFO - Using env: {'DISPLAY': ':0', 06:01:07 INFO - 'HOME': '/home/cltbld', 06:01:07 INFO - 'LANG': 'en_US.UTF-8', 06:01:07 INFO - 'LANGUAGE': 'en_US:en', 06:01:07 INFO - 'LOGNAME': 'cltbld', 06:01:07 INFO - 'MAIL': '/var/mail/cltbld', 06:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:07 INFO - 'MOZ_NO_REMOTE': '1', 06:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:07 INFO - 'NO_EM_RESTART': '1', 06:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:07 INFO - 'PWD': '/builds/slave/test', 06:01:07 INFO - 'SHELL': '/bin/bash', 06:01:07 INFO - 'SHLVL': '1', 06:01:07 INFO - 'TERM': 'linux', 06:01:07 INFO - 'TMOUT': '86400', 06:01:07 INFO - 'USER': 'cltbld', 06:01:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:07 INFO - '_': '/tools/buildbot/bin/python'} 06:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:07 INFO - Downloading/unpacking jsonschema==2.5.1 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:01:09 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 06:01:09 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 06:01:09 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 06:01:09 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 06:01:09 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 06:01:09 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 06:01:10 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:10 INFO - warning: no files found matching '*.txt' 06:01:10 INFO - no previously-included directories found matching 'build' 06:01:10 INFO - no previously-included directories found matching 'dist' 06:01:10 INFO - no previously-included directories found matching '.git*' 06:01:10 INFO - Installing collected packages: jsonschema, functools32 06:01:10 INFO - Running setup.py install for functools32 06:01:10 INFO - warning: no files found matching '*.txt' 06:01:10 INFO - no previously-included directories found matching 'build' 06:01:10 INFO - no previously-included directories found matching 'dist' 06:01:10 INFO - no previously-included directories found matching '.git*' 06:01:10 INFO - Successfully installed jsonschema functools32 06:01:10 INFO - Cleaning up... 06:01:10 INFO - Return code: 0 06:01:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:10 INFO - Running command: ['/builds/slave/test/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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:01:10 INFO - Copy/paste: /builds/slave/test/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 functools32==3.2.3-2 06:01:10 INFO - Using env: {'DISPLAY': ':0', 06:01:10 INFO - 'HOME': '/home/cltbld', 06:01:10 INFO - 'LANG': 'en_US.UTF-8', 06:01:10 INFO - 'LANGUAGE': 'en_US:en', 06:01:10 INFO - 'LOGNAME': 'cltbld', 06:01:10 INFO - 'MAIL': '/var/mail/cltbld', 06:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:10 INFO - 'MOZ_NO_REMOTE': '1', 06:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:10 INFO - 'NO_EM_RESTART': '1', 06:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:10 INFO - 'PWD': '/builds/slave/test', 06:01:10 INFO - 'SHELL': '/bin/bash', 06:01:10 INFO - 'SHLVL': '1', 06:01:10 INFO - 'TERM': 'linux', 06:01:10 INFO - 'TMOUT': '86400', 06:01:10 INFO - 'USER': 'cltbld', 06:01:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:10 INFO - '_': '/tools/buildbot/bin/python'} 06:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:01:10 INFO - Cleaning up... 06:01:10 INFO - Return code: 0 06:01:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:10 INFO - Running command: ['/builds/slave/test/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/build 06:01:10 INFO - Copy/paste: /builds/slave/test/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 06:01:10 INFO - Using env: {'DISPLAY': ':0', 06:01:10 INFO - 'HOME': '/home/cltbld', 06:01:10 INFO - 'LANG': 'en_US.UTF-8', 06:01:10 INFO - 'LANGUAGE': 'en_US:en', 06:01:10 INFO - 'LOGNAME': 'cltbld', 06:01:10 INFO - 'MAIL': '/var/mail/cltbld', 06:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:10 INFO - 'MOZ_NO_REMOTE': '1', 06:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:10 INFO - 'NO_EM_RESTART': '1', 06:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:10 INFO - 'PWD': '/builds/slave/test', 06:01:10 INFO - 'SHELL': '/bin/bash', 06:01:10 INFO - 'SHLVL': '1', 06:01:10 INFO - 'TERM': 'linux', 06:01:10 INFO - 'TMOUT': '86400', 06:01:10 INFO - 'USER': 'cltbld', 06:01:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:10 INFO - '_': '/tools/buildbot/bin/python'} 06:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:10 INFO - Downloading/unpacking blobuploader==1.2.4 06:01:10 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 06:01:10 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 06:01:10 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 06:01:10 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 06:01:10 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 06:01:10 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 06:01:12 INFO - Downloading blobuploader-1.2.4.tar.gz 06:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:01:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:01:12 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 06:01:12 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 06:01:12 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 06:01:12 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 06:01:12 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 06:01:12 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 06:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:01:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:13 INFO - Downloading docopt-0.6.1.tar.gz 06:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:01:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:01:13 INFO - Running setup.py install for blobuploader 06:01:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:01:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:01:13 INFO - Running setup.py install for requests 06:01:13 INFO - Running setup.py install for docopt 06:01:14 INFO - Successfully installed blobuploader requests docopt 06:01:14 INFO - Cleaning up... 06:01:14 INFO - Return code: 0 06:01:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:14 INFO - Using env: {'DISPLAY': ':0', 06:01:14 INFO - 'HOME': '/home/cltbld', 06:01:14 INFO - 'LANG': 'en_US.UTF-8', 06:01:14 INFO - 'LANGUAGE': 'en_US:en', 06:01:14 INFO - 'LOGNAME': 'cltbld', 06:01:14 INFO - 'MAIL': '/var/mail/cltbld', 06:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:14 INFO - 'MOZ_NO_REMOTE': '1', 06:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:14 INFO - 'NO_EM_RESTART': '1', 06:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:14 INFO - 'PWD': '/builds/slave/test', 06:01:14 INFO - 'SHELL': '/bin/bash', 06:01:14 INFO - 'SHLVL': '1', 06:01:14 INFO - 'TERM': 'linux', 06:01:14 INFO - 'TMOUT': '86400', 06:01:14 INFO - 'USER': 'cltbld', 06:01:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:14 INFO - '_': '/tools/buildbot/bin/python'} 06:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:14 INFO - Running setup.py (path:/tmp/pip-sMhktO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:14 INFO - Running setup.py (path:/tmp/pip-uF1gdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:14 INFO - Running setup.py (path:/tmp/pip-gek4E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:14 INFO - Running setup.py (path:/tmp/pip-cLrp2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:14 INFO - Running setup.py (path:/tmp/pip-1TopbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:14 INFO - Running setup.py (path:/tmp/pip-8rLQAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:14 INFO - Running setup.py (path:/tmp/pip-i3HWz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:14 INFO - Running setup.py (path:/tmp/pip-ulAjqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:14 INFO - Running setup.py (path:/tmp/pip-AFc7ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:14 INFO - Running setup.py (path:/tmp/pip-vBsLsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:15 INFO - Running setup.py (path:/tmp/pip-Cqmlh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:15 INFO - Running setup.py (path:/tmp/pip-WGwAPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:15 INFO - Running setup.py (path:/tmp/pip-6XCEEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:15 INFO - Running setup.py (path:/tmp/pip-guYQwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:15 INFO - Running setup.py (path:/tmp/pip-yYlNsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:15 INFO - Running setup.py (path:/tmp/pip-8TvBtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:15 INFO - Running setup.py (path:/tmp/pip-HuPxNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:15 INFO - Running setup.py install for manifestparser 06:01:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Running setup.py install for mozcrash 06:01:15 INFO - Running setup.py install for mozdebug 06:01:15 INFO - Running setup.py install for mozdevice 06:01:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:01:15 INFO - Running setup.py install for mozfile 06:01:16 INFO - Running setup.py install for mozhttpd 06:01:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for mozinfo 06:01:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for mozInstall 06:01:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for mozleak 06:01:16 INFO - Running setup.py install for mozlog 06:01:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for moznetwork 06:01:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for mozprocess 06:01:16 INFO - Running setup.py install for mozprofile 06:01:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:01:16 INFO - Running setup.py install for mozrunner 06:01:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:01:17 INFO - Running setup.py install for mozscreenshot 06:01:17 INFO - Running setup.py install for moztest 06:01:17 INFO - Running setup.py install for mozversion 06:01:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:01:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:17 INFO - Cleaning up... 06:01:17 INFO - Return code: 0 06:01:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:17 INFO - Using env: {'DISPLAY': ':0', 06:01:17 INFO - 'HOME': '/home/cltbld', 06:01:17 INFO - 'LANG': 'en_US.UTF-8', 06:01:17 INFO - 'LANGUAGE': 'en_US:en', 06:01:17 INFO - 'LOGNAME': 'cltbld', 06:01:17 INFO - 'MAIL': '/var/mail/cltbld', 06:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:17 INFO - 'MOZ_NO_REMOTE': '1', 06:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:17 INFO - 'NO_EM_RESTART': '1', 06:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:17 INFO - 'PWD': '/builds/slave/test', 06:01:17 INFO - 'SHELL': '/bin/bash', 06:01:17 INFO - 'SHLVL': '1', 06:01:17 INFO - 'TERM': 'linux', 06:01:17 INFO - 'TMOUT': '86400', 06:01:17 INFO - 'USER': 'cltbld', 06:01:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:17 INFO - '_': '/tools/buildbot/bin/python'} 06:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:17 INFO - Running setup.py (path:/tmp/pip-5v1JQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:17 INFO - Running setup.py (path:/tmp/pip-BZK1pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:17 INFO - Running setup.py (path:/tmp/pip-t4G748-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:17 INFO - Running setup.py (path:/tmp/pip-RqQStI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:17 INFO - Running setup.py (path:/tmp/pip-epNUU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:17 INFO - Running setup.py (path:/tmp/pip-m5_Nsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:18 INFO - Running setup.py (path:/tmp/pip-56tcFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:18 INFO - Running setup.py (path:/tmp/pip-zxxC9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:18 INFO - Running setup.py (path:/tmp/pip-C49MTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:18 INFO - Running setup.py (path:/tmp/pip-38FHCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:18 INFO - Running setup.py (path:/tmp/pip-hF0BZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:18 INFO - Running setup.py (path:/tmp/pip-tFMzZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:18 INFO - Running setup.py (path:/tmp/pip-TTsym4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:18 INFO - Running setup.py (path:/tmp/pip-C4qD6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:18 INFO - Running setup.py (path:/tmp/pip-c5OCSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:18 INFO - Running setup.py (path:/tmp/pip-6Q2S2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:18 INFO - Running setup.py (path:/tmp/pip-jPZPfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:01:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:20 INFO - Downloading blessings-1.6.tar.gz 06:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:20 INFO - Installing collected packages: blessings 06:01:20 INFO - Running setup.py install for blessings 06:01:20 INFO - Successfully installed blessings 06:01:20 INFO - Cleaning up... 06:01:21 INFO - Return code: 0 06:01:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:21 INFO - Reading from file tmpfile_stdout 06:01:21 INFO - Current package versions: 06:01:21 INFO - argparse == 1.2.1 06:01:21 INFO - blessings == 1.6 06:01:21 INFO - blobuploader == 1.2.4 06:01:21 INFO - docopt == 0.6.1 06:01:21 INFO - functools32 == 3.2.3-2 06:01:21 INFO - jsonschema == 2.5.1 06:01:21 INFO - manifestparser == 1.1 06:01:21 INFO - mozInstall == 1.12 06:01:21 INFO - mozcrash == 0.17 06:01:21 INFO - mozdebug == 0.1 06:01:21 INFO - mozdevice == 0.48 06:01:21 INFO - mozfile == 1.2 06:01:21 INFO - mozhttpd == 0.7 06:01:21 INFO - mozinfo == 0.9 06:01:21 INFO - mozleak == 0.1 06:01:21 INFO - mozlog == 3.4 06:01:21 INFO - moznetwork == 0.27 06:01:21 INFO - mozprocess == 0.23 06:01:21 INFO - mozprofile == 0.28 06:01:21 INFO - mozrunner == 6.12 06:01:21 INFO - mozscreenshot == 0.1 06:01:21 INFO - mozsystemmonitor == 0.3 06:01:21 INFO - moztest == 0.7 06:01:21 INFO - mozversion == 1.4 06:01:21 INFO - psutil == 3.1.1 06:01:21 INFO - requests == 1.2.3 06:01:21 INFO - wsgiref == 0.1.2 06:01:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:21 INFO - Using env: {'DISPLAY': ':0', 06:01:21 INFO - 'HOME': '/home/cltbld', 06:01:21 INFO - 'LANG': 'en_US.UTF-8', 06:01:21 INFO - 'LANGUAGE': 'en_US:en', 06:01:21 INFO - 'LOGNAME': 'cltbld', 06:01:21 INFO - 'MAIL': '/var/mail/cltbld', 06:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:21 INFO - 'MOZ_NO_REMOTE': '1', 06:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:21 INFO - 'NO_EM_RESTART': '1', 06:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:21 INFO - 'PWD': '/builds/slave/test', 06:01:21 INFO - 'SHELL': '/bin/bash', 06:01:21 INFO - 'SHLVL': '1', 06:01:21 INFO - 'TERM': 'linux', 06:01:21 INFO - 'TMOUT': '86400', 06:01:21 INFO - 'USER': 'cltbld', 06:01:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:21 INFO - '_': '/tools/buildbot/bin/python'} 06:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:01:21 INFO - Cleaning up... 06:01:21 INFO - Return code: 0 06:01:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f9d5cb27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eaa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:21 INFO - Running command: ['/builds/slave/test/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/build 06:01:21 INFO - Copy/paste: /builds/slave/test/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 06:01:21 INFO - Using env: {'DISPLAY': ':0', 06:01:21 INFO - 'HOME': '/home/cltbld', 06:01:21 INFO - 'LANG': 'en_US.UTF-8', 06:01:21 INFO - 'LANGUAGE': 'en_US:en', 06:01:21 INFO - 'LOGNAME': 'cltbld', 06:01:21 INFO - 'MAIL': '/var/mail/cltbld', 06:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:21 INFO - 'MOZ_NO_REMOTE': '1', 06:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:21 INFO - 'NO_EM_RESTART': '1', 06:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:21 INFO - 'PWD': '/builds/slave/test', 06:01:21 INFO - 'SHELL': '/bin/bash', 06:01:21 INFO - 'SHLVL': '1', 06:01:21 INFO - 'TERM': 'linux', 06:01:21 INFO - 'TMOUT': '86400', 06:01:21 INFO - 'USER': 'cltbld', 06:01:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:21 INFO - '_': '/tools/buildbot/bin/python'} 06:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:01:21 INFO - Cleaning up... 06:01:21 INFO - Return code: 0 06:01:21 INFO - Running post-action listener: _resource_record_post_action 06:01:21 INFO - Running post-action listener: _start_resource_monitoring 06:01:21 INFO - Starting resource monitoring. 06:01:21 INFO - [mozharness: 2016-11-02 13:01:21.760623Z] Finished create-virtualenv step (success) 06:01:21 INFO - [mozharness: 2016-11-02 13:01:21.761140Z] Running install step. 06:01:21 INFO - Running pre-action listener: _resource_record_pre_action 06:01:21 INFO - Running main action method: install 06:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:21 INFO - Reading from file tmpfile_stdout 06:01:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:22 INFO - Reading from file tmpfile_stdout 06:01:22 INFO - Output received: 06:01:22 INFO - Usage: mozinstall [options] installer 06:01:22 INFO - Options: 06:01:22 INFO - -h, --help show this help message and exit 06:01:22 INFO - -d DEST, --destination=DEST 06:01:22 INFO - Directory to install application into. [default: 06:01:22 INFO - "/builds/slave/test"] 06:01:22 INFO - --app=APP Application being installed. [default: firefox] 06:01:22 INFO - mkdir: /builds/slave/test/build/application 06:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:01:39 INFO - Reading from file tmpfile_stdout 06:01:39 INFO - Output received: 06:01:39 INFO - /builds/slave/test/build/application/firefox/firefox 06:01:39 INFO - Running post-action listener: _resource_record_post_action 06:01:39 INFO - [mozharness: 2016-11-02 13:01:39.007785Z] Finished install step (success) 06:01:39 INFO - [mozharness: 2016-11-02 13:01:39.008031Z] Running run-tests step. 06:01:39 INFO - Running pre-action listener: _resource_record_pre_action 06:01:39 INFO - Running main action method: run_tests 06:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:39 INFO - Python 2.7.3 06:01:39 INFO - Return code: 0 06:01:39 INFO - grabbing minidump binary from tooltool 06:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7930>, '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 0x1ea8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:01:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:01:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:01:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:39 INFO - Return code: 0 06:01:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:01:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:01:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:01:39 INFO - Using env: {'DISPLAY': ':0', 06:01:39 INFO - 'HOME': '/home/cltbld', 06:01:39 INFO - 'LANG': 'en_US.UTF-8', 06:01:39 INFO - 'LANGUAGE': 'en_US:en', 06:01:39 INFO - 'LOGNAME': 'cltbld', 06:01:39 INFO - 'MAIL': '/var/mail/cltbld', 06:01:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:39 INFO - 'MOZ_NO_REMOTE': '1', 06:01:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:39 INFO - 'NO_EM_RESTART': '1', 06:01:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:39 INFO - 'PWD': '/builds/slave/test', 06:01:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:39 INFO - 'SHELL': '/bin/bash', 06:01:39 INFO - 'SHLVL': '1', 06:01:39 INFO - 'TERM': 'linux', 06:01:39 INFO - 'TMOUT': '86400', 06:01:39 INFO - 'USER': 'cltbld', 06:01:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565', 06:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:39 INFO - '_': '/tools/buildbot/bin/python'} 06:01:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:01:39 INFO - mozversion application_buildid: 20161102030205 06:01:39 INFO - mozversion application_changeset: 3e73fd638e687a4d7f46613586e5156b8e2af846 06:01:39 INFO - mozversion application_display_name: Nightly 06:01:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:39 INFO - mozversion application_name: Firefox 06:01:39 INFO - mozversion application_remotingname: firefox 06:01:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:01:39 INFO - mozversion application_vendor: Mozilla 06:01:39 INFO - mozversion application_version: 52.0a1 06:01:39 INFO - mozversion platform_buildid: 20161102030205 06:01:39 INFO - mozversion platform_changeset: 3e73fd638e687a4d7f46613586e5156b8e2af846 06:01:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:01:39 INFO - mozversion platform_version: 52.0a1 06:01:39 INFO - using testdate: 1478091699 06:01:39 INFO - actual date: 1478091699 06:01:39 INFO - starting webserver on 'localhost:49119' 06:01:39 INFO - SUITE-START | Running 2 tests 06:01:39 INFO - TEST-START | dromaeo_css 06:01:39 INFO - operating with platform_type : linux_ 06:01:39 INFO - Initialising browser for dromaeo_css test... 06:01:39 INFO - TEST-INFO | started process 20447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbS0jo6/profile http://localhost:49119/getInfo.html) 06:01:43 INFO - PROCESS | 20447 | __metrics Screen width/height:1600/1200 06:01:43 INFO - PROCESS | 20447 | colorDepth:24 06:01:43 INFO - PROCESS | 20447 | Browser inner width/height: 1024/697 06:01:43 INFO - PROCESS | 20447 | __metrics 06:01:44 INFO - PROCESS | 20447 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:01:44 INFO - PROCESS | 20447 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:45 INFO - PROCESS | 20447 | console.error: PushService: 06:01:45 INFO - PROCESS | 20447 | stateChangeProcessEnqueue: Error transitioning state 06:01:45 INFO - PROCESS | 20447 | UnknownError 06:01:45 INFO - TEST-INFO | 20447: exit 0 06:01:45 INFO - Browser initialized. 06:01:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:01:45 INFO - TEST-INFO | started process 20530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbS0jo6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:57 INFO - PROCESS | 20530 | RSS: Main: 172331008 06:01:57 INFO - PROCESS | 20530 | 06:02:49 INFO - PROCESS | 20530 | 1478091769357 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] 06:05:00 INFO - PROCESS | 20530 | Cycle 1(1): loaded http://localhost:49119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49119/tests/dromaeo/cssquery-ext.html) 06:05:01 INFO - PROCESS | 20530 | RSS: Main: 310513664 06:05:01 INFO - PROCESS | 20530 | 06:08:04 INFO - PROCESS | 20530 | Cycle 1(1): loaded http://localhost:49119/tests/dromaeo/cssquery-ext.html (next: http://localhost:49119/tests/dromaeo/cssquery-jquery.html) 06:08:04 INFO - PROCESS | 20530 | RSS: Main: 267403264 06:08:04 INFO - PROCESS | 20530 | 06:11:06 INFO - PROCESS | 20530 | Cycle 1(1): loaded http://localhost:49119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49119/tests/dromaeo/cssquery-mootools.html) 06:11:07 INFO - PROCESS | 20530 | RSS: Main: 218742784 06:11:07 INFO - PROCESS | 20530 | 06:14:09 INFO - PROCESS | 20530 | Cycle 1(1): loaded http://localhost:49119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49119/tests/dromaeo/cssquery-prototype.html) 06:14:10 INFO - PROCESS | 20530 | RSS: Main: 247586816 06:14:10 INFO - PROCESS | 20530 | 06:17:12 INFO - PROCESS | 20530 | Cycle 1(1): loaded http://localhost:49119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49119/tests/dromaeo/cssquery-yui.html) 06:17:13 INFO - PROCESS | 20530 | RSS: Main: 216420352 06:17:13 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | Cycle 1(1): loaded http://localhost:49119/tests/dromaeo/cssquery-yui.html (next: http://localhost:49119/tests/dromaeo/cssquery-dojo.html) 06:20:16 INFO - PROCESS | 20530 | RSS: Main: 312737792 06:20:16 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | __start_tp_report 06:20:16 INFO - PROCESS | 20530 | _x_x_mozilla_page_load 06:20:16 INFO - PROCESS | 20530 | _x_x_mozilla_page_load_details 06:20:16 INFO - PROCESS | 20530 | |i|pagename|runs| 06:20:16 INFO - PROCESS | 20530 | |0;dojo.html;2987.8506074696265;3011.397720455908;3012.743916767074;3029.4546981543313;3063.2188791858075;5189.429162792099;5196.506331898473;5231.032259032082;5247.422783493813;5272.73636318184;5292.867678308035;5333.253344531769;5418.241446197536;5448.891022179554;5501.889962200754;4839.685420447678;4863.8540843774745;4911.336969509124;4936.654434189608;4944.33251511045;4980.750962451881;4986.87532811679;5044.798208071673;5050.166722490784;5051.898962020758;4873.975630121862;4886.169351210303;4932.753362331887;4980.302757613937;4985.900281994358;4762.595179409755;4791.47293797682;4813.350197723333;4861.027794441091;4861.343718597979;4784.64115191362;4800.7119572825395;4808.374911261549;4813.470518242991;4882.755862206911;5241.973790131063;5249.0971157176;5254.789808407659;5263.105272103751;5319.627626066138;5516.365617953947;5546.611737178399;5560.165975103726;5601.691906945116;5609.80365687199;5643.633163844378;5651.095824668075;5671.092625179951;5681.687507187103;5737.540996720252;5259.474052594748;5259.947400526023;5262.394824595182;5263.26314315996;5268.5521730652945;5669.688167150846;5715.399883012307;5724.042363654344;5784.161296611967;5802.361740208574;5577.693226872561;5605.215269862222;5612.242347283146;5615.663060216319;5616.438356164433;5641.492265696107;5676.091825307931;5689.175069614966;5689.402612725687;5691.544676425876;5600.803971860965;5669.121286200645;5720.570957178228;5736.053551164095;5742.196092547047;5698.458646428583;5708.058170401837;5715.342735585377;5768.884622307531;5780.479756821906;4384.167008268419;4388.824447022147;4390.341448782644;4390.824367025347;4442.73343599385;3883.0486530800135;3883.3786594145367;3888.2612303662213;3966.147278335114;3968.642822145963;5449.809256675997;5453.072977593819;5466.617336786467;5518.448155184449;5534.972325138348;5778.913316300259;5782.074868021096;5784.797532086357;5785.508231800344;5791.276090488689;5324.92012619811;5374.3013408256675;5445.128779395278;5450.8909821803345;5454.836354909359;4895.681780684244;4921.581665558396;4925.408950925912;4949.727764972961;5005.799768009311;5991.041433370639;5997.7001149942325;6003.369646187088;6006;6008.279006519246;5624.606277560531;5761.654300741969;5776.624519406225;5777.768889244383;5780.190773291826;5880.088586269135;5924.822255332347;5936.22829032223;5972.522198224218;5992.580519363602;5451.236826844324;5657.9151312731165;5672.376038635829;5723.599348045764;5734.598578099493;5780.739866705924;5781.248437703071;5781.595288329777;5783.739731712168;5792.478676919098;5391.137418013099;5555.2222688822785;5607.43925607436;5621.8594535136945;5622.212890195294;5447.591430642638;5465.6447330923365;5481.095619222783;5501.367342755634;5586.190002449704;5428.375736790162;5440.8639784004135;5465.562754979672;5470.972645136749;5471.72641367922;5534.7509362078;5547.528460080777;5549.750261238335;5557.305336832896;5559.777608895599;5299.099153144052;5300.920486192787;5450.1007333789485;5475.315585551806;5493.7802487900035 06:20:16 INFO - PROCESS | 20530 | |1;ext.html;553.4615665199522;591.5060924128353;604.691607280287;607.3622696169018;643.7811144210973;33505.162370940736;43095.78452107739;44112.55887441125;44233.11533769323;47823.76088119554;44633;44645.33032004523;44691;44726.55273447264;44820;7920.6039698014865;8769.561521923893;8927.866082008775;8928.107189281052;8930.955345223265;7954.2841144297;10518.842217366746;10735;10740.08709259714;11123.388213648246;10911;10987.560497580087;11003;11006.284591501526;11008.39453830039;10754;10849.67450976472;10849.945750271278;10860.67417977458;10860.67417977462;10618.309809862412;10668.733281668021;10700;10706.250562460631;10707.518161682743;42096;42485;42489.1502169958;42527.787361063;42528.57471425277;3372.8819491317686;3444.121748954001;3510.824458777051;3654.470101835219;3701.2967536168044;31609.20976975594;31674.040744906888;31965.680343196735;31975.6802431975;32452.513212301834;3524.2775231077567;3690.520232369775;3708.629137086297;3796.0130366105013;3919.4708714323488;342510.9999999975;344926;348095;349154;349379;60030.399696003355;60315.39684603098;60380;60592.39407605956;60617.69691151604;36040.819795900854;36624.08439789026;36628.81685591555;38840.61159388426;63761.36238637647;15687.372505099669;15816.36734530629;15861.206939652971;15870.285837137357;15872.60318492047;11003.944980275208;11220.102391808636;11630.94184529072;11705.122115841346;11811.645650630495;18940.064290035065;18969.715454268196;18972.715409268872;19090.427287181406;19320;6817.488688348394;6974.616396098263;7009.754658587027;7024;7042.753503627348;904.2901322461836;1014.7767491151935;1041.739565108723;1068.8396740488988;1175.58854400959;30197.547036794465;31219.21951951174;31372.843135784176;31592.52611210834;32079.51880721791;1092.306385445232;1104.5305745058317;1111.5998240633367;1129.5989923577176;1157.5659127827064;15820.92089539545;16555.420560280334;16715.331386744638;16778.412755553498;17207.1396430178;486736;490142;490152;491845;492922;57387.71306143526;57970;58050.41949580535;58061.70969145212;58071.709641451525;1207.1851500237306;1246.4079562207878;1315.0991570774052;1323.4904561743606;1338.4177882620897;30379.392412152076;31631;31909;32358;32928.506072408454;48312;48807.267890980955;48875.51124488709;48906.75546622244;48923;344972;346366;346549;346705;347821;27451.588226177024;27755.306117347227;28088.29779255535;28237.858810706635;28419.43161136807;43088.78455607702;46989;47163.29255061245;47459.52540474551;47531;39475.40786888142;39563.80218098891;39755.886660236356;40051.599484004786;41242;38529.49558278703;39230;39320;39523;41395;39145.49826769958;39921;40010.599894001854;40400.3939940907;40872;34103.82948085244;35644.643553564136;36667.44998825073;36800.81599592092;36882.07794805044;26636.20091397261;26653;27063.323416913947;27101.86449067742;27374.863125684245 06:20:16 INFO - PROCESS | 20530 | |2;jquery.html;351.6360566813349;355.5271488919737;378.44746669862;378.687582744236;399.02637564343;14075.4369825207;18144.90927545362;19175;20289.49276268094;20522.179112835467;18618.720719189223;19000.429987100375;19142.13860376283;19309.806901930977;19319.710204346946;5527.419620939803;5820.039693450575;5825.242718446596;5827.271591051119;5830.44610761979;3986.8205930733043;4939.481354457784;5687.459691329317;5798.304203495586;6288.276848162452;6347.8413039673915;6356.618602883842;6360.109584658151;6367.7771278005275;6370.58591191571;6127.448529632332;6342.968285158545;6349.52378571609;6389.297177310492;6395.328490508523;5606.411326810667;5606.607537472379;5607.8878422431735;5611.551075913917;5611.691356975365;18265;18365.7245141323;18431.447056588324;18435.354762583378;21267.893660531754;2154.795294447025;2231.141010710872;2247.6628505724107;2260.107257633226;2746.4507098580366;10055.195584353307;10689;12625.926796222333;14037.508687196001;14252.928735356361;1881.2569035231145;1896.4784684211813;1916.597514521952;1969.9733129246033;2000.339887837025;80142.19857801464;81600.77598836081;82127.5893620534;82696;90230.548847256;10565.418901960466;10849.304115339351;11073.723156921142;11124.590681343068;11168.162387820947;15426.151561663992;15618.609534761721;15623.921880390753;15628.68742625164;15643.765343519857;7547.886781698279;7676.961615191888;7769.106552746506;7871.842563148705;7985.121636619967;7182.42540596751;7189.820254493679;7198.208197098315;7420.443466739908;7434.665440055211;4773.522647735199;4804.855854324376;4818.638602104857;4849.2968519564465;4959.181735013754;1920.6254780317984;1968.2028778344793;2017.3947815655245;2019.1822311963679;2022.4033909996292;948.5684013773716;950.3062764182185;976.2239019979133;983.8439833196109;992.2161492420906;17764.200610972537;18878;18956.24175032983;19134.80865191358;19141.2343506261;929.6844964375333;938.0853667674099;972.411690926979;1000.0899181744722;1025.29254814178;10100.343477673927;10705.518251678694;10753.46232688378;10785.137189025016;10804.837927431096;450647;451014;453027;468891;469165;84951.57524212463;85560.57219713862;86213;86750.56624716836;88149.55925220333;956.3831328793028;959.098447459386;992.9702108936743;993.5677980078689;995.8506224066448;15761.290741916871;16134.919325403298;16270.349186032427;16864.662706745552;17065.91467042657;40182.79451616456;40980.3852942212;41162.38256426096;41441.79279103585;41695;54960;55487;55783.44216557783;56045.71977140088;57477.42522574721;8128.390370722102;8211.425200235926;8587.441816281922;8622.137786221578;8825.382223244567;11293.71765705864;12726.472823261269;12844.871551284368;13158.539451119164;13158.671033224246;11285.71785705364;11490.827637585277;12049.638510844688;12115.273083615011;12150.75698486043;10866.565337386415;11100;11126.443677815914;11235.382053987109;11362.94318528402;11033.393163376091;11099;11468.94265528667;11594.304341739522;11956.521739130685;8187.672493100209;8351.916480835114;8393.790155246168;8553.486790792324;8740.825183496167;10566.31318964265;11291.604793832505;11359.261647992855;11554.248973816675;11879.524819007143 06:20:16 INFO - PROCESS | 20530 | |3;mootools.html;1340.5777180188245;1427.785832125181;1480.3930388540698;1577.7002369549784;1741.6429631925464;7548.20743821899;8361.91638083619;8598;8606.268467180289;8780.385373023892;8559.443636163645;8631.784205394853;8642.91357086429;8663.87004194936;8665.133486651332;2281.3042022183226;2303.6774851520718;2307.0541078157958;2308.042162502568;2311.410590299471;2245.921392751254;2300.8734519601417;2327.8137748980125;2331.3588763090115;2340.602097643396;2295.1278514164596;2315.583195024895;2333.8016268617102;2353.223436266028;2359.834811563191;2263.4680850000236;2267.965980510294;2283.200879692111;2287.451011757183;2287.828412869033;2263.660450932357;2273.6134857074335;2276.0781883337277;2288.2448791898632;2291.049214575949;8601.95699021507;8683.175098365646;8723.869141962876;8759.605817738217;8912.955435222848;5111.846644600668;5241.895162096736;5246.23929530216;5250.97374513125;5263.34208223972;3263.400933542571;3378.4425569780956;3407.148212946763;3420.538227339302;3468.618451970281;1038.5378506564582;1042.99478502607;1073.620392833931;1074.1621535202555;1086.3916206924148;11974.22167559106;11989.040876729841;12088;12103.213291136137;12103.93948030263;4097.426360309559;4308.849190278325;4333.501647310537;4393.0994146199955;4408.118376324748;9599.856002159973;9621.90378096224;9623.951880240555;9626.855597166048;9629;5070.467600901926;5077.543021128043;5077.669951453217;5081.314022606901;5081.441041485507;4181.874543763692;4277.786110694453;4606.378138951199;4682.127149140303;4704.223803072455;3601.2797440512004;3653.9634603654154;3725.068732816796;3729.9067523312133;3747.306748251582;1107.4020029184312;1107.828286615576;1120.2998126171144;1120.618989543559;1130.909527237819;866.9869951950726;878.6485405837589;939.281449690987;951.414879848888;969.5588507229335;5971.880562388815;6033.125196846433;6060.696965151725;6064.9090263646085;6121.296050954197;437.49250868991817;454.0714239380475;454.2482191972291;462.4081176094604;468.250798722042;4081.469408976873;4134.979325103415;4199;4223.852165174204;4235.724677895927;10398.532066057045;10625.84061239082;10750.94624526888;10752.516136773707;10769.192310576738;10603.734906627242;10607.522661480252;10615.575376984834;10621.044106030495;10627.096696780705;7758.534487930742;8022.318102961197;8027.478213916077;8062.234087761653;8162.877556836652;5828.854278643068;5991.430814072656;6095.878082438415;6097.817065488042;6147.508199343953;9777.022297770167;9795;9811.803763924825;9835.60657573689;9946.850797238192;9762.414255144715;9847.704568862946;9928.553215105194;9975.800483990424;10067.446290453803;6991.440684745106;7173.24680908518;7176.138863336224;7656.9234307658435;7846.372290216655;7721.459497835098;7797.961010194913;7892;7937.722179723682;8010.118886922551;7257.419406447577;7285.417166626551;7387.261273872569;7524.2851929066655;7563.7352692655495;6914.446844252348;7146.213916469288;7174.461915356474;7189.532680375759;7192.2088570258275;6765.729370825112;6880.793576192722;6885.2770459101075;6889.827754306182;6893.896591551231;4815.590674792542;4918.409790825124;5003.799848006184;5029.446760856376;5049.332848554932;5064.848054558369;5218.66078704883;5245.527902488794;5325.147976323769;5339.065663508793 06:20:16 INFO - PROCESS | 20530 | |4;prototype.html;311.79109996302464;321.87125149940033;324.5440156580006;324.8424514110656;330.42506039491286;5122;5225.947740522593;5263.4210236874005;5292.417834038258;5292.523672869441;5065.594752419806;5131.923021154686;5179.223116532513;5180.274761533388;5187.391908508355;4113.218488487193;4125.66994640428;4132.7313724607875;4135.31767258402;4150.3566947123245;4004.2391945530403;4091.9590804091877;4161.791910404483;4163.04250022495;4167.291560434718;4040.9089545822612;4049.3521036634143;4050.574689657588;4051.2910240707906;4065.857694980676;4009.7594144351433;4027.536833264183;4029.9194016119804;4037.5356833964174;4039.53545342285;3535.186907011376;3539.699125574329;3550.6981906537717;3553.1650062235353;3556.751027428081;5008.84973450797;5102.209157580581;5118.795248190068;5120.641555091145;5142.794288228504;4594.2419500782335;4634.490206077328;4634.55971682693;4648.209804333272;4653.464851542082;5468.644538105011;5484.945150548483;5488.890222195574;5501.5323697485765;5503.2020357048405;3773.2642134783728;3812.7140464465274;3876.186000939806;3889.3971434427426;3946.1910308386714;5579.46995035471;5607.214989901417;5609.943900560983;5610.457124290812;5633.915491267634;3961.623645753649;3972.914220034505;3987.5613682494904;3994.9201015979515;3996.760194388346;3816.656500914931;4025.7520168747783;4027.4160246764054;4033.979830100831;4043.7262262387253;4613.492515823256;4622.976885115553;4623.306504024423;4624.907501849944;4639.211334073216;5438.673679579238;5471.671699698031;5492.588055895744;5530.170474428787;5565.137403702352;1315.684235783405;1331.681635181183;1374.5120482228865;1378.0835744230176;1393.8188035555313;868.3183700794846;880.4453194487432;887.9655201689959;901.4095767272447;916.1571354354011;4635.860924172281;4649.117107571439;4668.95331046692;4676.3632728544735;4702.670813043054;4853.344798452164;4882.633802464829;4885.95114048855;4900.730459824673;4927.827526036572;4647.34937108805;4672.789724462407;4674.69614475058;4675.906481870344;4684.648651351163;2792.2879665685527;3007.8343592613282;3014.5779590857296;3019.9547006794915;3029.9394012120074;5902.822915312548;5908.113782932594;5912.290525137011;5912.733926973297;5940.70296485174;5530.446955304437;5685.464924470452;5737.88524229513;5777.740001699934;5782.653040817564;5848.8537786554825;5851.151583020438;5856.531477481792;5862.530997520188;5914.58597898143;5565.30433695788;5567.415421380697;5607.831765047055;5648.63283886546;5699.430056994267;5314.937012597573;5565.30433695788;5575.2473416088305;5577.470140336662;5594.69229192382;5828.388019257917;5868.2077919480325;5874.823755287348;5877.23595932526;5899.852503687443;3975.7018223633922;4028.8589899353383;4054.459305463905;4054.6958978076173;4056.6551843093666;5400.918986215289;5651.2935883014625;5681;5681.801136960186;5694.402087780723;5355.277037599874;5403.83788486346;5535.750891209986;5545.750441230073;5570;5491.313585801775;5533.312339736258;5550.641861673629;5554.50009499147;5564.191637717839;5344.866378340573;5481.643693159932;5518.834434966958;5534.916976245279;5550.666959982414;5553.666779993213;5565.636419077352;5570.415106413769;5585.636933599303;5588.413216612197;5470.690232409335;5473.8357849264585;5485.917711234255;5490.286262785812;5490.556702267452 06:20:16 INFO - PROCESS | 20530 | |5;yui.html;748.9325960663542;759.1725019728497;767.4244316762428;827.7806381308952;828.8342331533695;13766.967477439195;14588;14641.92679036606;14729.26353682317;14734.852651473495;13503.324833758297;13663.863361366408;13704.794428083587;13707.314634268272;13725.039247252696;657.1063353838775;668.378408080485;780.9062912450514;784.5057613703359;807.9596020198996;796.7968168117151;806.2260230179036;806.2662976691212;806.5120602035772;806.9717559885405;858.2576071697968;860.096898256831;860.371928492201;860.5439117267858;861.1775754154799;690.3303795318533;707.2750430808411;828.5153185386556;862.4049405909902;862.6204470033165;625.2590680044117;632.6963057732314;632.7595513704763;633.3571425003626;633.486875630736;14436.783448248285;14447.205403702792;14462.421503139862;14474.927625361912;14477.42090316386;13178.802317965237;13260.204387736767;13436.596902092953;13567.321633918265;13678.589642310746;12090.879091209152;12333.62999110028;12494.187877788005;12748.171368860994;13128.6717832054;4238.0888109056705;4279.1869544786705;4340.978295108536;4396.758178300192;4482.484514280867;62074.689626552026;62296.37703622951;63166.684166578874;63199.68400158016;63543.364566354205;10442.63450779219;10466.319689220176;10560.049595536439;10570.15438764897;10740.838887416696;19395.224191032485;19397;19405.4178374649;19417.51456213606;19427.611447770967;7523.887141692879;7659.961700191575;7675.501092429086;7804.609769511501;8065.072516660542;4268.829246830092;4384.101259241847;4434.512203657595;4485.887852803706;4596.517365676623;3104.1308433638164;3185.1877771168206;3186.9203269917975;3187.6971687689634;3193.824339661341;553.5516231852213;556.6103727390843;580.9977788315123;587.6826513682649;592.4371846745609;606.445102731005;619.2878190081442;629.4233094780243;645.8417687666552;697.5814511293183;8639.395242333103;8791.692290769792;8906.959341481666;9075.870702374039;9509;614.4285814192843;636.8758092172075;648.5849056603778;669.6919417068203;686.3102581905254;4244.936325955113;4248.511421186541;4265.957340426618;4299.6775241856985;4352.912941741148;51114.233286500734;59208.70395647994;82226.58886705647;88232.1176788224;88774.11225887659;73763.26236737565;76370;76511;77231;77586;67254.08189084244;68875;69528.95706564406;69553.3044669557;69688.6515567429;7979.22685444408;8168.305694016075;8317.085120636846;8450.154984501502;8461.111583283666;33815.95704832064;45358.319625206306;45572.54427455683;45764;45918.770406147756;56812.715936420056;62686.373136268056;63056.36943630505;64133;65349;10252.38485690861;10502.894971050191;10676.199285053808;10783.838242426213;10857.782844342912;10859.83710244331;10959.178061645567;11240.662780116609;11312.490937907649;11728.237664551776;11029.393383363991;11046.447677616248;11464.94267528657;11714.1800073994;11878.465469054086;10734.677959661223;10934.562617495529;11171;11472.885271147516;11474.598389056677;10241.734696914336;10546.314489558154;10695.465226738788;10711.678649640524;11083.390413527333;8953.418027828171;9254.167124958785;9521.809563808823;9582.329236953625;9639.024000080108;9286.164245217962;9492.57283422234;9710.75723106928;9733;9735.513224338896 06:20:16 INFO - PROCESS | 20530 | __end_tp_report 06:20:16 INFO - PROCESS | 20530 | __start_cc_report 06:20:16 INFO - PROCESS | 20530 | _x_x_mozilla_cycle_collect,1313 06:20:16 INFO - PROCESS | 20530 | __end_cc_report 06:20:16 INFO - PROCESS | 20530 | __startTimestamp1478092816836__endTimestamp 06:20:16 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | ------- Summary: start ------- 06:20:16 INFO - PROCESS | 20530 | Number of tests: 6 06:20:16 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | [#0] dojo.html Cycles:165 Average:5299.38 Median:5470.97 stddev:602.13 (11.0%) stddev-sans-first:576.02 06:20:16 INFO - PROCESS | 20530 | Values: 2987.9 3011.4 3012.7 3029.5 3063.2 5189.4 5196.5 5231.0 5247.4 5272.7 5292.9 5333.3 5418.2 5448.9 5501.9 4839.7 4863.9 4911.3 4936.7 4944.3 4980.8 4986.9 5044.8 5050.2 5051.9 4874.0 4886.2 4932.8 4980.3 4985.9 4762.6 4791.5 4813.4 4861.0 4861.3 4784.6 4800.7 4808.4 4813.5 4882.8 5242.0 5249.1 5254.8 5263.1 5319.6 5516.4 5546.6 5560.2 5601.7 5609.8 5643.6 5651.1 5671.1 5681.7 5737.5 5259.5 5259.9 5262.4 5263.3 5268.6 5669.7 5715.4 5724.0 5784.2 5802.4 5577.7 5605.2 5612.2 5615.7 5616.4 5641.5 5676.1 5689.2 5689.4 5691.5 5600.8 5669.1 5720.6 5736.1 5742.2 5698.5 5708.1 5715.3 5768.9 5780.5 4384.2 4388.8 4390.3 4390.8 4442.7 3883.0 3883.4 3888.3 3966.1 3968.6 5449.8 5453.1 5466.6 5518.4 5535.0 5778.9 5782.1 5784.8 5785.5 5791.3 5324.9 5374.3 5445.1 5450.9 5454.8 4895.7 4921.6 4925.4 4949.7 5005.8 5991.0 5997.7 6003.4 6006.0 6008.3 5624.6 5761.7 5776.6 5777.8 5780.2 5880.1 5924.8 5936.2 5972.5 5992.6 5451.2 5657.9 5672.4 5723.6 5734.6 5780.7 5781.2 5781.6 5783.7 5792.5 5391.1 5555.2 5607.4 5621.9 5622.2 5447.6 5465.6 5481.1 5501.4 5586.2 5428.4 5440.9 5465.6 5471.0 5471.7 5534.8 5547.5 5549.8 5557.3 5559.8 5299.1 5300.9 5450.1 5475.3 5493.8 06:20:16 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | [#1] ext.html Cycles:180 Average:55767.18 Median:349266.50 stddev:105723.30 (30.3%) stddev-sans-first:105938.61 06:20:16 INFO - PROCESS | 20530 | Values: 553.5 591.5 604.7 607.4 643.8 33505.2 43095.8 44112.6 44233.1 47823.8 44633.0 44645.3 44691.0 44726.6 44820.0 7920.6 8769.6 8927.9 8928.1 8931.0 7954.3 10518.8 10735.0 10740.1 11123.4 10911.0 10987.6 11003.0 11006.3 11008.4 10754.0 10849.7 10849.9 10860.7 10860.7 10618.3 10668.7 10700.0 10706.3 10707.5 42096.0 42485.0 42489.2 42527.8 42528.6 3372.9 3444.1 3510.8 3654.5 3701.3 31609.2 31674.0 31965.7 31975.7 32452.5 3524.3 3690.5 3708.6 3796.0 3919.5 342511.0 344926.0 348095.0 349154.0 349379.0 60030.4 60315.4 60380.0 60592.4 60617.7 36040.8 36624.1 36628.8 38840.6 63761.4 15687.4 15816.4 15861.2 15870.3 15872.6 11003.9 11220.1 11630.9 11705.1 11811.6 18940.1 18969.7 18972.7 19090.4 19320.0 6817.5 6974.6 7009.8 7024.0 7042.8 904.3 1014.8 1041.7 1068.8 1175.6 30197.5 31219.2 31372.8 31592.5 32079.5 1092.3 1104.5 1111.6 1129.6 1157.6 15820.9 16555.4 16715.3 16778.4 17207.1 486736.0 490142.0 490152.0 491845.0 492922.0 57387.7 57970.0 58050.4 58061.7 58071.7 1207.2 1246.4 1315.1 1323.5 1338.4 30379.4 31631.0 31909.0 32358.0 32928.5 48312.0 48807.3 48875.5 48906.8 48923.0 344972.0 346366.0 346549.0 346705.0 347821.0 27451.6 27755.3 28088.3 28237.9 28419.4 43088.8 46989.0 47163.3 47459.5 47531.0 39475.4 39563.8 39755.9 40051.6 41242.0 38529.5 39230.0 39320.0 39523.0 41395.0 39145.5 39921.0 40010.6 40400.4 40872.0 34103.8 35644.6 36667.4 36800.8 36882.1 26636.2 26653.0 27063.3 27101.9 27374.9 06:20:16 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | [#2] jquery.html Cycles:180 Average:27793.42 Median:2182.75 stddev:75717.12 (3468.9%) stddev-sans-first:75901.49 06:20:16 INFO - PROCESS | 20530 | Values: 351.6 355.5 378.4 378.7 399.0 14075.4 18144.9 19175.0 20289.5 20522.2 18618.7 19000.4 19142.1 19309.8 19319.7 5527.4 5820.0 5825.2 5827.3 5830.4 3986.8 4939.5 5687.5 5798.3 6288.3 6347.8 6356.6 6360.1 6367.8 6370.6 6127.4 6343.0 6349.5 6389.3 6395.3 5606.4 5606.6 5607.9 5611.6 5611.7 18265.0 18365.7 18431.4 18435.4 21267.9 2154.8 2231.1 2247.7 2260.1 2746.5 10055.2 10689.0 12625.9 14037.5 14252.9 1881.3 1896.5 1916.6 1970.0 2000.3 80142.2 81600.8 82127.6 82696.0 90230.5 10565.4 10849.3 11073.7 11124.6 11168.2 15426.2 15618.6 15623.9 15628.7 15643.8 7547.9 7677.0 7769.1 7871.8 7985.1 7182.4 7189.8 7198.2 7420.4 7434.7 4773.5 4804.9 4818.6 4849.3 4959.2 1920.6 1968.2 2017.4 2019.2 2022.4 948.6 950.3 976.2 983.8 992.2 17764.2 18878.0 18956.2 19134.8 19141.2 929.7 938.1 972.4 1000.1 1025.3 10100.3 10705.5 10753.5 10785.1 10804.8 450647.0 451014.0 453027.0 468891.0 469165.0 84951.6 85560.6 86213.0 86750.6 88149.6 956.4 959.1 993.0 993.6 995.9 15761.3 16134.9 16270.3 16864.7 17065.9 40182.8 40980.4 41162.4 41441.8 41695.0 54960.0 55487.0 55783.4 56045.7 57477.4 8128.4 8211.4 8587.4 8622.1 8825.4 11293.7 12726.5 12844.9 13158.5 13158.7 11285.7 11490.8 12049.6 12115.3 12150.8 10866.6 11100.0 11126.4 11235.4 11362.9 11033.4 11099.0 11468.9 11594.3 11956.5 8187.7 8351.9 8393.8 8553.5 8740.8 10566.3 11291.6 11359.3 11554.2 11879.5 06:20:16 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | [#3] mootools.html Cycles:180 Average:5619.16 Median:5057.09 stddev:3208.80 (63.5%) stddev-sans-first:3201.69 06:20:16 INFO - PROCESS | 20530 | Values: 1340.6 1427.8 1480.4 1577.7 1741.6 7548.2 8361.9 8598.0 8606.3 8780.4 8559.4 8631.8 8642.9 8663.9 8665.1 2281.3 2303.7 2307.1 2308.0 2311.4 2245.9 2300.9 2327.8 2331.4 2340.6 2295.1 2315.6 2333.8 2353.2 2359.8 2263.5 2268.0 2283.2 2287.5 2287.8 2263.7 2273.6 2276.1 2288.2 2291.0 8602.0 8683.2 8723.9 8759.6 8913.0 5111.8 5241.9 5246.2 5251.0 5263.3 3263.4 3378.4 3407.1 3420.5 3468.6 1038.5 1043.0 1073.6 1074.2 1086.4 11974.2 11989.0 12088.0 12103.2 12103.9 4097.4 4308.8 4333.5 4393.1 4408.1 9599.9 9621.9 9624.0 9626.9 9629.0 5070.5 5077.5 5077.7 5081.3 5081.4 4181.9 4277.8 4606.4 4682.1 4704.2 3601.3 3654.0 3725.1 3729.9 3747.3 1107.4 1107.8 1120.3 1120.6 1130.9 867.0 878.6 939.3 951.4 969.6 5971.9 6033.1 6060.7 6064.9 6121.3 437.5 454.1 454.2 462.4 468.3 4081.5 4135.0 4199.0 4223.9 4235.7 10398.5 10625.8 10750.9 10752.5 10769.2 10603.7 10607.5 10615.6 10621.0 10627.1 7758.5 8022.3 8027.5 8062.2 8162.9 5828.9 5991.4 6095.9 6097.8 6147.5 9777.0 9795.0 9811.8 9835.6 9946.9 9762.4 9847.7 9928.6 9975.8 10067.4 6991.4 7173.2 7176.1 7656.9 7846.4 7721.5 7798.0 7892.0 7937.7 8010.1 7257.4 7285.4 7387.3 7524.3 7563.7 6914.4 7146.2 7174.5 7189.5 7192.2 6765.7 6880.8 6885.3 6889.8 6893.9 4815.6 4918.4 5003.8 5029.4 5049.3 5064.8 5218.7 5245.5 5325.1 5339.1 06:20:16 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | [#4] prototype.html Cycles:180 Average:4570.54 Median:5126.96 stddev:1357.92 (26.5%) stddev-sans-first:1323.57 06:20:16 INFO - PROCESS | 20530 | Values: 311.8 321.9 324.5 324.8 330.4 5122.0 5225.9 5263.4 5292.4 5292.5 5065.6 5131.9 5179.2 5180.3 5187.4 4113.2 4125.7 4132.7 4135.3 4150.4 4004.2 4092.0 4161.8 4163.0 4167.3 4040.9 4049.4 4050.6 4051.3 4065.9 4009.8 4027.5 4029.9 4037.5 4039.5 3535.2 3539.7 3550.7 3553.2 3556.8 5008.8 5102.2 5118.8 5120.6 5142.8 4594.2 4634.5 4634.6 4648.2 4653.5 5468.6 5484.9 5488.9 5501.5 5503.2 3773.3 3812.7 3876.2 3889.4 3946.2 5579.5 5607.2 5609.9 5610.5 5633.9 3961.6 3972.9 3987.6 3994.9 3996.8 3816.7 4025.8 4027.4 4034.0 4043.7 4613.5 4623.0 4623.3 4624.9 4639.2 5438.7 5471.7 5492.6 5530.2 5565.1 1315.7 1331.7 1374.5 1378.1 1393.8 868.3 880.4 888.0 901.4 916.2 4635.9 4649.1 4669.0 4676.4 4702.7 4853.3 4882.6 4886.0 4900.7 4927.8 4647.3 4672.8 4674.7 4675.9 4684.6 2792.3 3007.8 3014.6 3020.0 3029.9 5902.8 5908.1 5912.3 5912.7 5940.7 5530.4 5685.5 5737.9 5777.7 5782.7 5848.9 5851.2 5856.5 5862.5 5914.6 5565.3 5567.4 5607.8 5648.6 5699.4 5314.9 5565.3 5575.2 5577.5 5594.7 5828.4 5868.2 5874.8 5877.2 5899.9 3975.7 4028.9 4054.5 4054.7 4056.7 5400.9 5651.3 5681.0 5681.8 5694.4 5355.3 5403.8 5535.8 5545.8 5570.0 5491.3 5533.3 5550.6 5554.5 5564.2 5344.9 5481.6 5518.8 5534.9 5550.7 5553.7 5565.6 5570.4 5585.6 5588.4 5470.7 5473.8 5485.9 5490.3 5490.6 06:20:16 INFO - PROCESS | 20530 | 06:20:16 INFO - PROCESS | 20530 | [#5] yui.html Cycles:180 Average:16890.80 Median:590.06 stddev:22591.49 (3828.7%) stddev-sans-first:22622.35 06:20:16 INFO - PROCESS | 20530 | Values: 748.9 759.2 767.4 827.8 828.8 13767.0 14588.0 14641.9 14729.3 14734.9 13503.3 13663.9 13704.8 13707.3 13725.0 657.1 668.4 780.9 784.5 808.0 796.8 806.2 806.3 806.5 807.0 858.3 860.1 860.4 860.5 861.2 690.3 707.3 828.5 862.4 862.6 625.3 632.7 632.8 633.4 633.5 14436.8 14447.2 14462.4 14474.9 14477.4 13178.8 13260.2 13436.6 13567.3 13678.6 12090.9 12333.6 12494.2 12748.2 13128.7 4238.1 4279.2 4341.0 4396.8 4482.5 62074.7 62296.4 63166.7 63199.7 63543.4 10442.6 10466.3 10560.0 10570.2 10740.8 19395.2 19397.0 19405.4 19417.5 19427.6 7523.9 7660.0 7675.5 7804.6 8065.1 4268.8 4384.1 4434.5 4485.9 4596.5 3104.1 3185.2 3186.9 3187.7 3193.8 553.6 556.6 581.0 587.7 592.4 606.4 619.3 629.4 645.8 697.6 8639.4 8791.7 8907.0 9075.9 9509.0 614.4 636.9 648.6 669.7 686.3 4244.9 4248.5 4266.0 4299.7 4352.9 51114.2 59208.7 82226.6 88232.1 88774.1 73763.3 76370.0 76511.0 77231.0 77586.0 67254.1 68875.0 69529.0 69553.3 69688.7 7979.2 8168.3 8317.1 8450.2 8461.1 33816.0 45358.3 45572.5 45764.0 45918.8 56812.7 62686.4 63056.4 64133.0 65349.0 10252.4 10502.9 10676.2 10783.8 10857.8 10859.8 10959.2 11240.7 11312.5 11728.2 11029.4 11046.4 11464.9 11714.2 11878.5 10734.7 10934.6 11171.0 11472.9 11474.6 10241.7 10546.3 10695.5 10711.7 11083.4 8953.4 9254.2 9521.8 9582.3 9639.0 9286.2 9492.6 9710.8 9733.0 9735.5 06:20:16 INFO - PROCESS | 20530 | -------- Summary: end -------- 06:20:16 INFO - PROCESS | 20530 | 06:20:17 INFO - TEST-INFO | 20530: exit 0 06:20:17 INFO - TEST-OK | dromaeo_css | took 1118562ms 06:20:17 INFO - TEST-START | kraken 06:20:17 INFO - operating with platform_type : linux_ 06:20:17 INFO - Initialising browser for kraken test... 06:20:17 INFO - TEST-INFO | started process 20841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZQs4y3/profile http://localhost:49119/getInfo.html) 06:20:21 INFO - PROCESS | 20841 | __metrics Screen width/height:1600/1200 06:20:21 INFO - PROCESS | 20841 | colorDepth:24 06:20:21 INFO - PROCESS | 20841 | Browser inner width/height: 1024/697 06:20:21 INFO - PROCESS | 20841 | __metrics 06:20:22 INFO - PROCESS | 20841 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:20:22 INFO - PROCESS | 20841 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:23 INFO - PROCESS | 20841 | console.error: PushService: 06:20:23 INFO - PROCESS | 20841 | stateChangeProcessEnqueue: Error transitioning state 06:20:23 INFO - PROCESS | 20841 | UnknownError 06:20:23 INFO - TEST-INFO | 20841: exit 0 06:20:23 INFO - Browser initialized. 06:20:23 INFO - Running cycle 1/1 for kraken test... 06:20:23 INFO - TEST-INFO | started process 20923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZQs4y3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:35 INFO - PROCESS | 20923 | RSS: Main: 174542848 06:20:35 INFO - PROCESS | 20923 | 06:20:38 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49119/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:39 INFO - PROCESS | 20923 | RSS: Main: 229076992 06:20:39 INFO - PROCESS | 20923 | 06:20:41 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49119/tests/kraken/driver.html?testName=audio-dft) 06:20:42 INFO - PROCESS | 20923 | RSS: Main: 216956928 06:20:42 INFO - PROCESS | 20923 | 06:20:45 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49119/tests/kraken/driver.html?testName=audio-fft) 06:20:46 INFO - PROCESS | 20923 | RSS: Main: 298135552 06:20:46 INFO - PROCESS | 20923 | 06:20:48 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49119/tests/kraken/driver.html?testName=audio-oscillator) 06:20:49 INFO - PROCESS | 20923 | RSS: Main: 208588800 06:20:49 INFO - PROCESS | 20923 | 06:20:51 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:51 INFO - PROCESS | 20923 | RSS: Main: 212365312 06:20:51 INFO - PROCESS | 20923 | 06:20:54 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49119/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:55 INFO - PROCESS | 20923 | RSS: Main: 248172544 06:20:55 INFO - PROCESS | 20923 | 06:20:58 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49119/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:59 INFO - PROCESS | 20923 | RSS: Main: 246611968 06:20:59 INFO - PROCESS | 20923 | 06:21:01 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49119/tests/kraken/driver.html?testName=json-parse-financial) 06:21:02 INFO - PROCESS | 20923 | RSS: Main: 246636544 06:21:02 INFO - PROCESS | 20923 | 06:21:03 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:04 INFO - PROCESS | 20923 | RSS: Main: 209051648 06:21:04 INFO - PROCESS | 20923 | 06:21:06 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49119/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:21:06 INFO - PROCESS | 20923 | RSS: Main: 216801280 06:21:06 INFO - PROCESS | 20923 | 06:21:08 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:21:09 INFO - PROCESS | 20923 | RSS: Main: 225705984 06:21:09 INFO - PROCESS | 20923 | 06:21:12 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:21:12 INFO - PROCESS | 20923 | RSS: Main: 234729472 06:21:12 INFO - PROCESS | 20923 | 06:21:15 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:21:16 INFO - PROCESS | 20923 | RSS: Main: 231313408 06:21:16 INFO - PROCESS | 20923 | 06:21:17 INFO - PROCESS | 20923 | Cycle 1(1): loaded http://localhost:49119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49119/tests/kraken/driver.html?testName=ai-astar) 06:21:18 INFO - PROCESS | 20923 | RSS: Main: 282488832 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | __start_tp_report 06:21:18 INFO - PROCESS | 20923 | _x_x_mozilla_page_load 06:21:18 INFO - PROCESS | 20923 | _x_x_mozilla_page_load_details 06:21:18 INFO - PROCESS | 20923 | |i|pagename|runs| 06:21:18 INFO - PROCESS | 20923 | |0;ai-astar;104;112;112;111;112;111;111;112;110;111 06:21:18 INFO - PROCESS | 20923 | |1;audio-beat-detection;149;123;122;162;127;123;124;123;152;122 06:21:18 INFO - PROCESS | 20923 | |2;audio-dft;162;160;159;163;160;161;160;162;161;162 06:21:18 INFO - PROCESS | 20923 | |3;audio-fft;74;76;77;108;77;77;77;76;106;75 06:21:18 INFO - PROCESS | 20923 | |4;audio-oscillator;84;82;120;83;84;83;104;83;84;125 06:21:18 INFO - PROCESS | 20923 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;117;117 06:21:18 INFO - PROCESS | 20923 | |6;imaging-darkroom;146;145;146;146;146;145;145;146;146;145 06:21:18 INFO - PROCESS | 20923 | |7;imaging-desaturate;85;84;84;85;84;84;84;84;84;85 06:21:18 INFO - PROCESS | 20923 | |8;json-parse-financial;55;52;53;53;53;54;54;55;54;54 06:21:18 INFO - PROCESS | 20923 | |9;json-stringify-tinderbox;60;61;60;61;61;61;61;61;61;62 06:21:18 INFO - PROCESS | 20923 | |10;stanford-crypto-aes;79;79;82;84;79;83;79;79;79;82 06:21:18 INFO - PROCESS | 20923 | |11;stanford-crypto-ccm;129;139;139;129;130;140;129;134;197;140 06:21:18 INFO - PROCESS | 20923 | |12;stanford-crypto-pbkdf2;167;166;170;174;165;168;167;164;163;164 06:21:18 INFO - PROCESS | 20923 | |13;stanford-crypto-sha256-iterative;67;66;67;66;65;64;64;63;63;65 06:21:18 INFO - PROCESS | 20923 | __end_tp_report 06:21:18 INFO - PROCESS | 20923 | __start_cc_report 06:21:18 INFO - PROCESS | 20923 | _x_x_mozilla_cycle_collect,1689 06:21:18 INFO - PROCESS | 20923 | __end_cc_report 06:21:18 INFO - PROCESS | 20923 | __startTimestamp1478092878242__endTimestamp 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | ------- Summary: start ------- 06:21:18 INFO - PROCESS | 20923 | Number of tests: 14 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.41 (2.2%) stddev-sans-first:0.71 06:21:18 INFO - PROCESS | 20923 | Values: 104.0 112.0 112.0 111.0 112.0 111.0 111.0 112.0 110.0 111.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:125.50 stddev:15.33 (12.2%) stddev-sans-first:15.09 06:21:18 INFO - PROCESS | 20923 | Values: 149.0 123.0 122.0 162.0 127.0 123.0 124.0 123.0 152.0 122.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 06:21:18 INFO - PROCESS | 20923 | Values: 162.0 160.0 159.0 163.0 160.0 161.0 160.0 162.0 161.0 162.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.50 stddev:13.06 (17.1%) stddev-sans-first:13.51 06:21:18 INFO - PROCESS | 20923 | Values: 74.0 76.0 77.0 108.0 77.0 77.0 77.0 76.0 106.0 75.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:83.00 stddev:16.79 (20.2%) stddev-sans-first:17.48 06:21:18 INFO - PROCESS | 20923 | Values: 84.0 82.0 120.0 83.0 84.0 83.0 104.0 83.0 84.0 125.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:21:18 INFO - PROCESS | 20923 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:21:18 INFO - PROCESS | 20923 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 06:21:18 INFO - PROCESS | 20923 | Values: 85.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 85.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.95 (1.8%) stddev-sans-first:0.88 06:21:18 INFO - PROCESS | 20923 | Values: 55.0 52.0 53.0 53.0 53.0 54.0 54.0 55.0 54.0 54.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 06:21:18 INFO - PROCESS | 20923 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:2.01 (2.5%) stddev-sans-first:2.06 06:21:18 INFO - PROCESS | 20923 | Values: 79.0 79.0 82.0 84.0 79.0 83.0 79.0 79.0 79.0 82.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:139.00 stddev:20.40 (14.7%) stddev-sans-first:21.20 06:21:18 INFO - PROCESS | 20923 | Values: 129.0 139.0 139.0 129.0 130.0 140.0 129.0 134.0 197.0 140.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:3.29 (2.0%) stddev-sans-first:3.49 06:21:18 INFO - PROCESS | 20923 | Values: 167.0 166.0 170.0 174.0 165.0 168.0 167.0 164.0 163.0 164.0 06:21:18 INFO - PROCESS | 20923 | 06:21:18 INFO - PROCESS | 20923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:1.49 (2.3%) stddev-sans-first:1.39 06:21:18 INFO - PROCESS | 20923 | Values: 67.0 66.0 67.0 66.0 65.0 64.0 64.0 63.0 63.0 65.0 06:21:18 INFO - PROCESS | 20923 | -------- Summary: end -------- 06:21:18 INFO - PROCESS | 20923 | 06:21:19 INFO - TEST-INFO | 20923: exit 0 06:21:19 INFO - TEST-OK | kraken | took 61702ms 06:21:19 INFO - SUITE-END | took 1180s 06:21:19 INFO - Completed test suite (00:19:40) 06:21:19 INFO - javascript benchmark 06:21:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.8506074696265, 3011.397720455908, 3012.743916767074, 3029.4546981543313, 3063.2188791858075, 5189.429162792099, 5196.506331898473, 5231.032259032082, 5247.422783493813, 5272.73636318184, 5292.867678308035, 5333.253344531769, 5418.241446197536, 5448.891022179554, 5501.889962200754, 4839.685420447678, 4863.8540843774745, 4911.336969509124, 4936.654434189608, 4944.33251511045, 4980.750962451881, 4986.87532811679, 5044.798208071673, 5050.166722490784, 5051.898962020758, 4873.975630121862, 4886.169351210303, 4932.753362331887, 4980.302757613937, 4985.900281994358, 4762.595179409755, 4791.47293797682, 4813.350197723333, 4861.027794441091, 4861.343718597979, 4784.64115191362, 4800.7119572825395, 4808.374911261549, 4813.470518242991, 4882.755862206911, 5241.973790131063, 5249.0971157176, 5254.789808407659, 5263.105272103751, 5319.627626066138, 5516.365617953947, 5546.611737178399, 5560.165975103726, 5601.691906945116, 5609.80365687199, 5643.633163844378, 5651.095824668075, 5671.092625179951, 5681.687507187103, 5737.540996720252, 5259.474052594748, 5259.947400526023, 5262.394824595182, 5263.26314315996, 5268.5521730652945, 5669.688167150846, 5715.399883012307, 5724.042363654344, 5784.161296611967, 5802.361740208574, 5577.693226872561, 5605.215269862222, 5612.242347283146, 5615.663060216319, 5616.438356164433, 5641.492265696107, 5676.091825307931, 5689.175069614966, 5689.402612725687, 5691.544676425876, 5600.803971860965, 5669.121286200645, 5720.570957178228, 5736.053551164095, 5742.196092547047, 5698.458646428583, 5708.058170401837, 5715.342735585377, 5768.884622307531, 5780.479756821906, 4384.167008268419, 4388.824447022147, 4390.341448782644, 4390.824367025347, 4442.73343599385, 3883.0486530800135, 3883.3786594145367, 3888.2612303662213, 3966.147278335114, 3968.642822145963, 5449.809256675997, 5453.072977593819, 5466.617336786467, 5518.448155184449, 5534.972325138348, 5778.913316300259, 5782.074868021096, 5784.797532086357, 5785.508231800344, 5791.276090488689, 5324.92012619811, 5374.3013408256675, 5445.128779395278, 5450.8909821803345, 5454.836354909359, 4895.681780684244, 4921.581665558396, 4925.408950925912, 4949.727764972961, 5005.799768009311, 5991.041433370639, 5997.7001149942325, 6003.369646187088, 6006.0, 6008.279006519246, 5624.606277560531, 5761.654300741969, 5776.624519406225, 5777.768889244383, 5780.190773291826, 5880.088586269135, 5924.822255332347, 5936.22829032223, 5972.522198224218, 5992.580519363602, 5451.236826844324, 5657.9151312731165, 5672.376038635829, 5723.599348045764, 5734.598578099493, 5780.739866705924, 5781.248437703071, 5781.595288329777, 5783.739731712168, 5792.478676919098, 5391.137418013099, 5555.2222688822785, 5607.43925607436, 5621.8594535136945, 5622.212890195294, 5447.591430642638, 5465.6447330923365, 5481.095619222783, 5501.367342755634, 5586.190002449704, 5428.375736790162, 5440.8639784004135, 5465.562754979672, 5470.972645136749, 5471.72641367922, 5534.7509362078, 5547.528460080777, 5549.750261238335, 5557.305336832896, 5559.777608895599, 5299.099153144052, 5300.920486192787, 5450.1007333789485, 5475.315585551806, 5493.7802487900035], "value": 5258.201115298367, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4615665199522, 591.5060924128353, 604.691607280287, 607.3622696169018, 643.7811144210973, 33505.162370940736, 43095.78452107739, 44112.55887441125, 44233.11533769323, 47823.76088119554, 44633.0, 44645.33032004523, 44691.0, 44726.55273447264, 44820.0, 7920.6039698014865, 8769.561521923893, 8927.866082008775, 8928.107189281052, 8930.955345223265, 7954.2841144297, 10518.842217366746, 10735.0, 10740.08709259714, 11123.388213648246, 10911.0, 10987.560497580087, 11003.0, 11006.284591501526, 11008.39453830039, 10754.0, 10849.67450976472, 10849.945750271278, 10860.67417977458, 10860.67417977462, 10618.309809862412, 10668.733281668021, 10700.0, 10706.250562460631, 10707.518161682743, 42096.0, 42485.0, 42489.1502169958, 42527.787361063, 42528.57471425277, 3372.8819491317686, 3444.121748954001, 3510.824458777051, 3654.470101835219, 3701.2967536168044, 31609.20976975594, 31674.040744906888, 31965.680343196735, 31975.6802431975, 32452.513212301834, 3524.2775231077567, 3690.520232369775, 3708.629137086297, 3796.0130366105013, 3919.4708714323488, 342510.9999999975, 344926.0, 348095.0, 349154.0, 349379.0, 60030.399696003355, 60315.39684603098, 60380.0, 60592.39407605956, 60617.69691151604, 36040.819795900854, 36624.08439789026, 36628.81685591555, 38840.61159388426, 63761.36238637647, 15687.372505099669, 15816.36734530629, 15861.206939652971, 15870.285837137357, 15872.60318492047, 11003.944980275208, 11220.102391808636, 11630.94184529072, 11705.122115841346, 11811.645650630495, 18940.064290035065, 18969.715454268196, 18972.715409268872, 19090.427287181406, 19320.0, 6817.488688348394, 6974.616396098263, 7009.754658587027, 7024.0, 7042.753503627348, 904.2901322461836, 1014.7767491151935, 1041.739565108723, 1068.8396740488988, 1175.58854400959, 30197.547036794465, 31219.21951951174, 31372.843135784176, 31592.52611210834, 32079.51880721791, 1092.306385445232, 1104.5305745058317, 1111.5998240633367, 1129.5989923577176, 1157.5659127827064, 15820.92089539545, 16555.420560280334, 16715.331386744638, 16778.412755553498, 17207.1396430178, 486736.0, 490142.0, 490152.0, 491845.0, 492922.0, 57387.71306143526, 57970.0, 58050.41949580535, 58061.70969145212, 58071.709641451525, 1207.1851500237306, 1246.4079562207878, 1315.0991570774052, 1323.4904561743606, 1338.4177882620897, 30379.392412152076, 31631.0, 31909.0, 32358.0, 32928.506072408454, 48312.0, 48807.267890980955, 48875.51124488709, 48906.75546622244, 48923.0, 344972.0, 346366.0, 346549.0, 346705.0, 347821.0, 27451.588226177024, 27755.306117347227, 28088.29779255535, 28237.858810706635, 28419.43161136807, 43088.78455607702, 46989.0, 47163.29255061245, 47459.52540474551, 47531.0, 39475.40786888142, 39563.80218098891, 39755.886660236356, 40051.599484004786, 41242.0, 38529.49558278703, 39230.0, 39320.0, 39523.0, 41395.0, 39145.49826769958, 39921.0, 40010.599894001854, 40400.3939940907, 40872.0, 34103.82948085244, 35644.643553564136, 36667.44998825073, 36800.81599592092, 36882.07794805044, 26636.20091397261, 26653.0, 27063.323416913947, 27101.86449067742, 27374.863125684245], "value": 19793.034453012737, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.6360566813349, 355.5271488919737, 378.44746669862, 378.687582744236, 399.02637564343, 14075.4369825207, 18144.90927545362, 19175.0, 20289.49276268094, 20522.179112835467, 18618.720719189223, 19000.429987100375, 19142.13860376283, 19309.806901930977, 19319.710204346946, 5527.419620939803, 5820.039693450575, 5825.242718446596, 5827.271591051119, 5830.44610761979, 3986.8205930733043, 4939.481354457784, 5687.459691329317, 5798.304203495586, 6288.276848162452, 6347.8413039673915, 6356.618602883842, 6360.109584658151, 6367.7771278005275, 6370.58591191571, 6127.448529632332, 6342.968285158545, 6349.52378571609, 6389.297177310492, 6395.328490508523, 5606.411326810667, 5606.607537472379, 5607.8878422431735, 5611.551075913917, 5611.691356975365, 18265.0, 18365.7245141323, 18431.447056588324, 18435.354762583378, 21267.893660531754, 2154.795294447025, 2231.141010710872, 2247.6628505724107, 2260.107257633226, 2746.4507098580366, 10055.195584353307, 10689.0, 12625.926796222333, 14037.508687196001, 14252.928735356361, 1881.2569035231145, 1896.4784684211813, 1916.597514521952, 1969.9733129246033, 2000.339887837025, 80142.19857801464, 81600.77598836081, 82127.5893620534, 82696.0, 90230.548847256, 10565.418901960466, 10849.304115339351, 11073.723156921142, 11124.590681343068, 11168.162387820947, 15426.151561663992, 15618.609534761721, 15623.921880390753, 15628.68742625164, 15643.765343519857, 7547.886781698279, 7676.961615191888, 7769.106552746506, 7871.842563148705, 7985.121636619967, 7182.42540596751, 7189.820254493679, 7198.208197098315, 7420.443466739908, 7434.665440055211, 4773.522647735199, 4804.855854324376, 4818.638602104857, 4849.2968519564465, 4959.181735013754, 1920.6254780317984, 1968.2028778344793, 2017.3947815655245, 2019.1822311963679, 2022.4033909996292, 948.5684013773716, 950.3062764182185, 976.2239019979133, 983.8439833196109, 992.2161492420906, 17764.200610972537, 18878.0, 18956.24175032983, 19134.80865191358, 19141.2343506261, 929.6844964375333, 938.0853667674099, 972.411690926979, 1000.0899181744722, 1025.29254814178, 10100.343477673927, 10705.518251678694, 10753.46232688378, 10785.137189025016, 10804.837927431096, 450647.0, 451014.0, 453027.0, 468891.0, 469165.0, 84951.57524212463, 85560.57219713862, 86213.0, 86750.56624716836, 88149.55925220333, 956.3831328793028, 959.098447459386, 992.9702108936743, 993.5677980078689, 995.8506224066448, 15761.290741916871, 16134.919325403298, 16270.349186032427, 16864.662706745552, 17065.91467042657, 40182.79451616456, 40980.3852942212, 41162.38256426096, 41441.79279103585, 41695.0, 54960.0, 55487.0, 55783.44216557783, 56045.71977140088, 57477.42522574721, 8128.390370722102, 8211.425200235926, 8587.441816281922, 8622.137786221578, 8825.382223244567, 11293.71765705864, 12726.472823261269, 12844.871551284368, 13158.539451119164, 13158.671033224246, 11285.71785705364, 11490.827637585277, 12049.638510844688, 12115.273083615011, 12150.75698486043, 10866.565337386415, 11100.0, 11126.443677815914, 11235.382053987109, 11362.94318528402, 11033.393163376091, 11099.0, 11468.94265528667, 11594.304341739522, 11956.521739130685, 8187.672493100209, 8351.916480835114, 8393.790155246168, 8553.486790792324, 8740.825183496167, 10566.31318964265, 11291.604793832505, 11359.261647992855, 11554.248973816675, 11879.524819007143], "value": 9086.56681227032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.5777180188245, 1427.785832125181, 1480.3930388540698, 1577.7002369549784, 1741.6429631925464, 7548.20743821899, 8361.91638083619, 8598.0, 8606.268467180289, 8780.385373023892, 8559.443636163645, 8631.784205394853, 8642.91357086429, 8663.87004194936, 8665.133486651332, 2281.3042022183226, 2303.6774851520718, 2307.0541078157958, 2308.042162502568, 2311.410590299471, 2245.921392751254, 2300.8734519601417, 2327.8137748980125, 2331.3588763090115, 2340.602097643396, 2295.1278514164596, 2315.583195024895, 2333.8016268617102, 2353.223436266028, 2359.834811563191, 2263.4680850000236, 2267.965980510294, 2283.200879692111, 2287.451011757183, 2287.828412869033, 2263.660450932357, 2273.6134857074335, 2276.0781883337277, 2288.2448791898632, 2291.049214575949, 8601.95699021507, 8683.175098365646, 8723.869141962876, 8759.605817738217, 8912.955435222848, 5111.846644600668, 5241.895162096736, 5246.23929530216, 5250.97374513125, 5263.34208223972, 3263.400933542571, 3378.4425569780956, 3407.148212946763, 3420.538227339302, 3468.618451970281, 1038.5378506564582, 1042.99478502607, 1073.620392833931, 1074.1621535202555, 1086.3916206924148, 11974.22167559106, 11989.040876729841, 12088.0, 12103.213291136137, 12103.93948030263, 4097.426360309559, 4308.849190278325, 4333.501647310537, 4393.0994146199955, 4408.118376324748, 9599.856002159973, 9621.90378096224, 9623.951880240555, 9626.855597166048, 9629.0, 5070.467600901926, 5077.543021128043, 5077.669951453217, 5081.314022606901, 5081.441041485507, 4181.874543763692, 4277.786110694453, 4606.378138951199, 4682.127149140303, 4704.223803072455, 3601.2797440512004, 3653.9634603654154, 3725.068732816796, 3729.9067523312133, 3747.306748251582, 1107.4020029184312, 1107.828286615576, 1120.2998126171144, 1120.618989543559, 1130.909527237819, 866.9869951950726, 878.6485405837589, 939.281449690987, 951.414879848888, 969.5588507229335, 5971.880562388815, 6033.125196846433, 6060.696965151725, 6064.9090263646085, 6121.296050954197, 437.49250868991817, 454.0714239380475, 454.2482191972291, 462.4081176094604, 468.250798722042, 4081.469408976873, 4134.979325103415, 4199.0, 4223.852165174204, 4235.724677895927, 10398.532066057045, 10625.84061239082, 10750.94624526888, 10752.516136773707, 10769.192310576738, 10603.734906627242, 10607.522661480252, 10615.575376984834, 10621.044106030495, 10627.096696780705, 7758.534487930742, 8022.318102961197, 8027.478213916077, 8062.234087761653, 8162.877556836652, 5828.854278643068, 5991.430814072656, 6095.878082438415, 6097.817065488042, 6147.508199343953, 9777.022297770167, 9795.0, 9811.803763924825, 9835.60657573689, 9946.850797238192, 9762.414255144715, 9847.704568862946, 9928.553215105194, 9975.800483990424, 10067.446290453803, 6991.440684745106, 7173.24680908518, 7176.138863336224, 7656.9234307658435, 7846.372290216655, 7721.459497835098, 7797.961010194913, 7892.0, 7937.722179723682, 8010.118886922551, 7257.419406447577, 7285.417166626551, 7387.261273872569, 7524.2851929066655, 7563.7352692655495, 6914.446844252348, 7146.213916469288, 7174.461915356474, 7189.532680375759, 7192.2088570258275, 6765.729370825112, 6880.793576192722, 6885.2770459101075, 6889.827754306182, 6893.896591551231, 4815.590674792542, 4918.409790825124, 5003.799848006184, 5029.446760856376, 5049.332848554932, 5064.848054558369, 5218.66078704883, 5245.527902488794, 5325.147976323769, 5339.065663508793], "value": 4417.398611303874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.79109996302464, 321.87125149940033, 324.5440156580006, 324.8424514110656, 330.42506039491286, 5122.0, 5225.947740522593, 5263.4210236874005, 5292.417834038258, 5292.523672869441, 5065.594752419806, 5131.923021154686, 5179.223116532513, 5180.274761533388, 5187.391908508355, 4113.218488487193, 4125.66994640428, 4132.7313724607875, 4135.31767258402, 4150.3566947123245, 4004.2391945530403, 4091.9590804091877, 4161.791910404483, 4163.04250022495, 4167.291560434718, 4040.9089545822612, 4049.3521036634143, 4050.574689657588, 4051.2910240707906, 4065.857694980676, 4009.7594144351433, 4027.536833264183, 4029.9194016119804, 4037.5356833964174, 4039.53545342285, 3535.186907011376, 3539.699125574329, 3550.6981906537717, 3553.1650062235353, 3556.751027428081, 5008.84973450797, 5102.209157580581, 5118.795248190068, 5120.641555091145, 5142.794288228504, 4594.2419500782335, 4634.490206077328, 4634.55971682693, 4648.209804333272, 4653.464851542082, 5468.644538105011, 5484.945150548483, 5488.890222195574, 5501.5323697485765, 5503.2020357048405, 3773.2642134783728, 3812.7140464465274, 3876.186000939806, 3889.3971434427426, 3946.1910308386714, 5579.46995035471, 5607.214989901417, 5609.943900560983, 5610.457124290812, 5633.915491267634, 3961.623645753649, 3972.914220034505, 3987.5613682494904, 3994.9201015979515, 3996.760194388346, 3816.656500914931, 4025.7520168747783, 4027.4160246764054, 4033.979830100831, 4043.7262262387253, 4613.492515823256, 4622.976885115553, 4623.306504024423, 4624.907501849944, 4639.211334073216, 5438.673679579238, 5471.671699698031, 5492.588055895744, 5530.170474428787, 5565.137403702352, 1315.684235783405, 1331.681635181183, 1374.5120482228865, 1378.0835744230176, 1393.8188035555313, 868.3183700794846, 880.4453194487432, 887.9655201689959, 901.4095767272447, 916.1571354354011, 4635.860924172281, 4649.117107571439, 4668.95331046692, 4676.3632728544735, 4702.670813043054, 4853.344798452164, 4882.633802464829, 4885.95114048855, 4900.730459824673, 4927.827526036572, 4647.34937108805, 4672.789724462407, 4674.69614475058, 4675.906481870344, 4684.648651351163, 2792.2879665685527, 3007.8343592613282, 3014.5779590857296, 3019.9547006794915, 3029.9394012120074, 5902.822915312548, 5908.113782932594, 5912.290525137011, 5912.733926973297, 5940.70296485174, 5530.446955304437, 5685.464924470452, 5737.88524229513, 5777.740001699934, 5782.653040817564, 5848.8537786554825, 5851.151583020438, 5856.531477481792, 5862.530997520188, 5914.58597898143, 5565.30433695788, 5567.415421380697, 5607.831765047055, 5648.63283886546, 5699.430056994267, 5314.937012597573, 5565.30433695788, 5575.2473416088305, 5577.470140336662, 5594.69229192382, 5828.388019257917, 5868.2077919480325, 5874.823755287348, 5877.23595932526, 5899.852503687443, 3975.7018223633922, 4028.8589899353383, 4054.459305463905, 4054.6958978076173, 4056.6551843093666, 5400.918986215289, 5651.2935883014625, 5681.0, 5681.801136960186, 5694.402087780723, 5355.277037599874, 5403.83788486346, 5535.750891209986, 5545.750441230073, 5570.0, 5491.313585801775, 5533.312339736258, 5550.641861673629, 5554.50009499147, 5564.191637717839, 5344.866378340573, 5481.643693159932, 5518.834434966958, 5534.916976245279, 5550.666959982414, 5553.666779993213, 5565.636419077352, 5570.415106413769, 5585.636933599303, 5588.413216612197, 5470.690232409335, 5473.8357849264585, 5485.917711234255, 5490.286262785812, 5490.556702267452], "value": 4134.835536265993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.9325960663542, 759.1725019728497, 767.4244316762428, 827.7806381308952, 828.8342331533695, 13766.967477439195, 14588.0, 14641.92679036606, 14729.26353682317, 14734.852651473495, 13503.324833758297, 13663.863361366408, 13704.794428083587, 13707.314634268272, 13725.039247252696, 657.1063353838775, 668.378408080485, 780.9062912450514, 784.5057613703359, 807.9596020198996, 796.7968168117151, 806.2260230179036, 806.2662976691212, 806.5120602035772, 806.9717559885405, 858.2576071697968, 860.096898256831, 860.371928492201, 860.5439117267858, 861.1775754154799, 690.3303795318533, 707.2750430808411, 828.5153185386556, 862.4049405909902, 862.6204470033165, 625.2590680044117, 632.6963057732314, 632.7595513704763, 633.3571425003626, 633.486875630736, 14436.783448248285, 14447.205403702792, 14462.421503139862, 14474.927625361912, 14477.42090316386, 13178.802317965237, 13260.204387736767, 13436.596902092953, 13567.321633918265, 13678.589642310746, 12090.879091209152, 12333.62999110028, 12494.187877788005, 12748.171368860994, 13128.6717832054, 4238.0888109056705, 4279.1869544786705, 4340.978295108536, 4396.758178300192, 4482.484514280867, 62074.689626552026, 62296.37703622951, 63166.684166578874, 63199.68400158016, 63543.364566354205, 10442.63450779219, 10466.319689220176, 10560.049595536439, 10570.15438764897, 10740.838887416696, 19395.224191032485, 19397.0, 19405.4178374649, 19417.51456213606, 19427.611447770967, 7523.887141692879, 7659.961700191575, 7675.501092429086, 7804.609769511501, 8065.072516660542, 4268.829246830092, 4384.101259241847, 4434.512203657595, 4485.887852803706, 4596.517365676623, 3104.1308433638164, 3185.1877771168206, 3186.9203269917975, 3187.6971687689634, 3193.824339661341, 553.5516231852213, 556.6103727390843, 580.9977788315123, 587.6826513682649, 592.4371846745609, 606.445102731005, 619.2878190081442, 629.4233094780243, 645.8417687666552, 697.5814511293183, 8639.395242333103, 8791.692290769792, 8906.959341481666, 9075.870702374039, 9509.0, 614.4285814192843, 636.8758092172075, 648.5849056603778, 669.6919417068203, 686.3102581905254, 4244.936325955113, 4248.511421186541, 4265.957340426618, 4299.6775241856985, 4352.912941741148, 51114.233286500734, 59208.70395647994, 82226.58886705647, 88232.1176788224, 88774.11225887659, 73763.26236737565, 76370.0, 76511.0, 77231.0, 77586.0, 67254.08189084244, 68875.0, 69528.95706564406, 69553.3044669557, 69688.6515567429, 7979.22685444408, 8168.305694016075, 8317.085120636846, 8450.154984501502, 8461.111583283666, 33815.95704832064, 45358.319625206306, 45572.54427455683, 45764.0, 45918.770406147756, 56812.715936420056, 62686.373136268056, 63056.36943630505, 64133.0, 65349.0, 10252.38485690861, 10502.894971050191, 10676.199285053808, 10783.838242426213, 10857.782844342912, 10859.83710244331, 10959.178061645567, 11240.662780116609, 11312.490937907649, 11728.237664551776, 11029.393383363991, 11046.447677616248, 11464.94267528657, 11714.1800073994, 11878.465469054086, 10734.677959661223, 10934.562617495529, 11171.0, 11472.885271147516, 11474.598389056677, 10241.734696914336, 10546.314489558154, 10695.465226738788, 10711.678649640524, 11083.390413527333, 8953.418027828171, 9254.167124958785, 9521.809563808823, 9582.329236953625, 9639.024000080108, 9286.164245217962, 9492.57283422234, 9710.75723106928, 9733.0, 9735.513224338896], "value": 6744.83195224547, "unit": "score"}], "name": "dromaeo_css", "value": 6988.738018401585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0, 112.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 122.0, 162.0, 127.0, 123.0, 124.0, 123.0, 152.0, 122.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 159.0, 163.0, 160.0, 161.0, 160.0, 162.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 108.0, 77.0, 77.0, 77.0, 76.0, 106.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 120.0, 83.0, 84.0, 83.0, 104.0, 83.0, 84.0, 125.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 82.0, 84.0, 79.0, 83.0, 79.0, 79.0, 79.0, 82.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 139.0, 139.0, 129.0, 130.0, 140.0, 129.0, 134.0, 197.0, 140.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 170.0, 174.0, 165.0, 168.0, 167.0, 164.0, 163.0, 164.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 65.0, 64.0, 64.0, 63.0, 63.0, 65.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1494.4999999999998, "alertThreshold": 2.0}]} 06:21:19 INFO - Return code: 0 06:21:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:21:20 INFO - # TBPL SUCCESS # 06:21:20 INFO - Running post-action listener: _resource_record_post_action 06:21:20 INFO - [mozharness: 2016-11-02 13:21:20.053895Z] Finished run-tests step (success) 06:21:20 INFO - Running post-run listener: _resource_record_post_run 06:21:20 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392437760; Read time: 20; Write time: 550148 06:21:20 INFO - TinderboxPrint: CPU usage
13.1% 06:21:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:21:20 INFO - TinderboxPrint: I/O write bytes / time
392,437,760 / 550,148 06:21:20 INFO - TinderboxPrint: CPU idle
8,305.4 (86.9%) 06:21:20 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 06:21:20 INFO - TinderboxPrint: Swap in / out
0 / 0 06:21:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103743488; Read time: 0; Write time: 198476 06:21:20 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288694272; Read time: 0; Write time: 351672 06:21:20 INFO - Running post-run listener: _upload_blobber_files 06:21:20 INFO - Blob upload gear active. 06:21:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:21:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:21:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:21:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:21 INFO - (blobuploader) - INFO - Done attempting. 06:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:21:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:22 INFO - (blobuploader) - INFO - Done attempting. 06:21:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:21:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:21:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:26 INFO - (blobuploader) - INFO - Done attempting. 06:21:26 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:26 INFO - Return code: 0 06:21:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:21:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7484170719655671ca1cc29862de46e75a0193025c1ea3c720c7cc8681183048b7842627fe73b92660496c18010ce40c55a6fe932fc2408dc2379a469eb4443d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b518109d9a143b9eb9775550184cd9339ce5e4071b9f069d2fa8d00ff7c8ed561fe1efe2be7bf335ee8a5a1adcf9ee0ab8b5ec587c33c71b3dd88b9b3dbb578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc4cf5f455df2aa4afe184a0f1fa0996bfef882480348c9f2c2be5e661736cb02f8242ff8126989c97ff787e3df22b8e574aa3c24ac2dbf7c5d04c01b19aa255"} 06:21:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:21:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:21:26 INFO - Contents: 06:21:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7484170719655671ca1cc29862de46e75a0193025c1ea3c720c7cc8681183048b7842627fe73b92660496c18010ce40c55a6fe932fc2408dc2379a469eb4443d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b518109d9a143b9eb9775550184cd9339ce5e4071b9f069d2fa8d00ff7c8ed561fe1efe2be7bf335ee8a5a1adcf9ee0ab8b5ec587c33c71b3dd88b9b3dbb578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc4cf5f455df2aa4afe184a0f1fa0996bfef882480348c9f2c2be5e661736cb02f8242ff8126989c97ff787e3df22b8e574aa3c24ac2dbf7c5d04c01b19aa255"} 06:21:26 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:26 INFO - Copying logs to upload dir... 06:21:26 INFO - mkdir: /builds/slave/test/build/upload/logs 06:21:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.819957 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-02 06:21:25.910092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 06:21:25.913582) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7484170719655671ca1cc29862de46e75a0193025c1ea3c720c7cc8681183048b7842627fe73b92660496c18010ce40c55a6fe932fc2408dc2379a469eb4443d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b518109d9a143b9eb9775550184cd9339ce5e4071b9f069d2fa8d00ff7c8ed561fe1efe2be7bf335ee8a5a1adcf9ee0ab8b5ec587c33c71b3dd88b9b3dbb578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc4cf5f455df2aa4afe184a0f1fa0996bfef882480348c9f2c2be5e661736cb02f8242ff8126989c97ff787e3df22b8e574aa3c24ac2dbf7c5d04c01b19aa255"} build_url:https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/C95L1PYyQ7KmPEzZZL6B5A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7484170719655671ca1cc29862de46e75a0193025c1ea3c720c7cc8681183048b7842627fe73b92660496c18010ce40c55a6fe932fc2408dc2379a469eb4443d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b518109d9a143b9eb9775550184cd9339ce5e4071b9f069d2fa8d00ff7c8ed561fe1efe2be7bf335ee8a5a1adcf9ee0ab8b5ec587c33c71b3dd88b9b3dbb578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc4cf5f455df2aa4afe184a0f1fa0996bfef882480348c9f2c2be5e661736cb02f8242ff8126989c97ff787e3df22b8e574aa3c24ac2dbf7c5d04c01b19aa255"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 06:21:25.939479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 06:21:25.939806) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1478091643.677160-1619766565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 06:21:26.021919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 06:21:26.022240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 06:21:26.022541) ========= ========= Total master_lag: 0.17 =========